builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-016 starttime: 1476105283.62 results: success (0) buildid: 20161010043001 builduid: 3ccae19c87ac4946946a5a457f163f28 revision: 7be6b348c431d69f96f0765af3a0c0a0fe56d4bf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-10 06:14:43.620173) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-10 06:14:43.620578) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-10 06:14:43.620950) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-10 06:14:43.671948) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 06:14:43.672229) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1476104369.968406-649384278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-10 06:14:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 23.6M=0s 2016-10-10 06:14:44 (23.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.208906 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 06:14:43.895167) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 06:14:43.895489) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1476104369.968406-649384278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014275 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 06:14:43.944535) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 06:14:43.944906) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7be6b348c431d69f96f0765af3a0c0a0fe56d4bf --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 7be6b348c431d69f96f0765af3a0c0a0fe56d4bf --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1476104369.968406-649384278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-10 06:14:44,915 truncating revision to first 12 chars 2016-10-10 06:14:44,915 Setting DEBUG logging. 2016-10-10 06:14:44,915 attempt 1/10 2016-10-10 06:14:44,915 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7be6b348c431?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-10 06:14:45,331 unpacking tar archive at: mozilla-central-7be6b348c431/testing/mozharness/ program finished with exit code 0 elapsedTime=0.825034 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 06:14:44.782963) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-10 06:14:44.783237) ========= script_repo_revision: 7be6b348c431d69f96f0765af3a0c0a0fe56d4bf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-10 06:14:44.783596) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-10 06:14:44.783876) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-10 06:14:44.791527) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-10-10 06:14:44.791808) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1476104369.968406-649384278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:14:45 INFO - MultiFileLogger online at 20161010 06:14:45 in /builds/slave/test 06:14:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:14:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:14:45 INFO - {'append_to_log': False, 06:14:45 INFO - 'base_work_dir': '/builds/slave/test', 06:14:45 INFO - 'blob_upload_branch': 'Firefox', 06:14:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:14:45 INFO - 'branch': 'Firefox', 06:14:45 INFO - 'buildbot_json_path': 'buildprops.json', 06:14:45 INFO - 'config_files': ('talos/linux_config.py',), 06:14:45 INFO - 'default_actions': ('clobber', 06:14:45 INFO - 'read-buildbot-config', 06:14:45 INFO - 'download-and-extract', 06:14:45 INFO - 'populate-webroot', 06:14:45 INFO - 'create-virtualenv', 06:14:45 INFO - 'install', 06:14:45 INFO - 'run-tests'), 06:14:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:14:45 INFO - 'download_minidump_stackwalk': True, 06:14:45 INFO - 'download_symbols': 'ondemand', 06:14:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:14:45 INFO - 'tooltool.py': '/tools/tooltool.py', 06:14:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:14:45 INFO - '/tools/misc-python/virtualenv.py')}, 06:14:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:14:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:14:45 INFO - 'installer_path': 'installer.exe', 06:14:45 INFO - 'log_level': 'info', 06:14:45 INFO - 'log_name': 'talos', 06:14:45 INFO - 'log_to_console': True, 06:14:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:14:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:14:45 INFO - 'opt_config_files': (), 06:14:45 INFO - 'pip_index': False, 06:14:45 INFO - 'sps_profile': False, 06:14:45 INFO - 'sps_profile_interval': 0, 06:14:45 INFO - 'suite': 'dromaeojs', 06:14:45 INFO - 'system_bits': '32', 06:14:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:14:45 INFO - 'title': 'talos-linux64-ix-016', 06:14:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:14:45 INFO - 'use_talos_json': True, 06:14:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:14:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:14:45 INFO - 'work_dir': 'build'} 06:14:45 INFO - [mozharness: 2016-10-10 13:14:45.857494Z] Running clobber step. 06:14:45 INFO - Running pre-action listener: _resource_record_pre_action 06:14:45 INFO - Running main action method: clobber 06:14:45 INFO - rmtree: /builds/slave/test/build 06:14:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:14:46 INFO - Running post-action listener: _resource_record_post_action 06:14:46 INFO - [mozharness: 2016-10-10 13:14:46.321669Z] Finished clobber step (success) 06:14:46 INFO - [mozharness: 2016-10-10 13:14:46.321770Z] Running read-buildbot-config step. 06:14:46 INFO - Running pre-action listener: _resource_record_pre_action 06:14:46 INFO - Running main action method: read_buildbot_config 06:14:46 INFO - Using buildbot properties: 06:14:46 INFO - { 06:14:46 INFO - "project": "", 06:14:46 INFO - "product": "firefox", 06:14:46 INFO - "script_repo_revision": "production", 06:14:46 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:14:46 INFO - "repository": "", 06:14:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 06:14:46 INFO - "buildid": "20161010043001", 06:14:46 INFO - "pgo_build": "True", 06:14:46 INFO - "basedir": "/builds/slave/test", 06:14:46 INFO - "buildnumber": 4, 06:14:46 INFO - "slavename": "talos-linux64-ix-016", 06:14:46 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:14:46 INFO - "platform": "ubuntu64_hw", 06:14:46 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:14:46 INFO - "branch": "mozilla-central", 06:14:46 INFO - "repo_path": "mozilla-central", 06:14:46 INFO - "revision": "7be6b348c431d69f96f0765af3a0c0a0fe56d4bf", 06:14:46 INFO - "stage_platform": "linux64-pgo", 06:14:46 INFO - "builduid": "3ccae19c87ac4946946a5a457f163f28", 06:14:46 INFO - "slavebuilddir": "test" 06:14:46 INFO - } 06:14:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/Rhc8FJFoTrCs83uThm9E3A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 06:14:46 INFO - Running post-action listener: _resource_record_post_action 06:14:46 INFO - [mozharness: 2016-10-10 13:14:46.324261Z] Finished read-buildbot-config step (success) 06:14:46 INFO - [mozharness: 2016-10-10 13:14:46.324350Z] Running download-and-extract step. 06:14:46 INFO - Running pre-action listener: _resource_record_pre_action 06:14:46 INFO - Running main action method: download_and_extract 06:14:46 INFO - mkdir: /builds/slave/test/build/tests 06:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:46 INFO - trying https://queue.taskcluster.net/v1/task/Rhc8FJFoTrCs83uThm9E3A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:14:46 INFO - Downloading https://queue.taskcluster.net/v1/task/Rhc8FJFoTrCs83uThm9E3A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:14:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rhc8FJFoTrCs83uThm9E3A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:14:46 INFO - Downloaded 1361 bytes. 06:14:46 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:14:46 INFO - Using the following test package requirements: 06:14:46 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:14:46 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:14:46 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:14:46 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:46 INFO - u'jsshell-linux-x86_64.zip'], 06:14:46 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:14:46 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:14:46 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:14:46 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:14:46 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:14:46 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:14:46 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:14:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Rhc8FJFoTrCs83uThm9E3A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:14:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rhc8FJFoTrCs83uThm9E3A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:14:46 INFO - Fetch https://queue.taskcluster.net/v1/task/Rhc8FJFoTrCs83uThm9E3A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:14:47 INFO - Http code: 200 06:14:47 INFO - via: 1.1 373880a309382d9266a9313233b86d25.cloudfront.net (CloudFront) 06:14:47 INFO - x-amz-cf-id: D2QkeZd806PIJoD8oIpi_3t7jTIJn9q9DBkqzJoy9sY73_cht-p5Hw== 06:14:47 INFO - x-amz-version-id: aC2tU8l0yKSRyHUtvCuzaqzfDVFkzu3a 06:14:48 INFO - Expected file size: 22089220 06:14:48 INFO - Obtained file size: 22089220 06:14:52 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:14:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Rhc8FJFoTrCs83uThm9E3A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:14:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rhc8FJFoTrCs83uThm9E3A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:14:52 INFO - Fetch https://queue.taskcluster.net/v1/task/Rhc8FJFoTrCs83uThm9E3A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:14:53 INFO - Http code: 200 06:14:53 INFO - via: 1.1 8e86372eaaa62fc64b70e7bcde725dd9.cloudfront.net (CloudFront) 06:14:53 INFO - x-amz-cf-id: 42_AdldMZaqQvOj37sxHUrOogxRDIzwbiVJm13LdEPELI1cG4MVGkw== 06:14:53 INFO - x-amz-version-id: aC2tU8l0yKSRyHUtvCuzaqzfDVFkzu3a 06:14:53 INFO - Expected file size: 22089220 06:14:53 INFO - Obtained file size: 22089220 06:14:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Rhc8FJFoTrCs83uThm9E3A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 06:14:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rhc8FJFoTrCs83uThm9E3A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:14:57 INFO - Fetch https://queue.taskcluster.net/v1/task/Rhc8FJFoTrCs83uThm9E3A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 06:14:58 INFO - Http code: 200 06:14:58 INFO - via: 1.1 0576b942ae9f4fc9c0b62b0736e9bfd6.cloudfront.net (CloudFront) 06:14:58 INFO - x-amz-cf-id: zHSfjvRcQvS7EA75PJdjokkPjsPWnHLJoh6ISxnXnzrRsbRqsQUQsg== 06:14:58 INFO - x-amz-version-id: MLJKPV.BTPWzaZpu0zGAg0cYEgFzclKK 06:14:59 INFO - Expected file size: 14409006 06:14:59 INFO - Obtained file size: 14409006 06:14:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:59 INFO - trying https://queue.taskcluster.net/v1/task/Rhc8FJFoTrCs83uThm9E3A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:14:59 INFO - Downloading https://queue.taskcluster.net/v1/task/Rhc8FJFoTrCs83uThm9E3A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:14:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rhc8FJFoTrCs83uThm9E3A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:15:01 INFO - Downloaded 59740361 bytes. 06:15:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Rhc8FJFoTrCs83uThm9E3A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:15:01 INFO - mkdir: /builds/slave/test/properties 06:15:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:15:01 INFO - Writing to file /builds/slave/test/properties/build_url 06:15:01 INFO - Contents: 06:15:01 INFO - build_url:https://queue.taskcluster.net/v1/task/Rhc8FJFoTrCs83uThm9E3A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:15:02 INFO - Running post-action listener: _resource_record_post_action 06:15:02 INFO - Running post-action listener: set_extra_try_arguments 06:15:02 INFO - [mozharness: 2016-10-10 13:15:02.166733Z] Finished download-and-extract step (success) 06:15:02 INFO - [mozharness: 2016-10-10 13:15:02.166961Z] Running populate-webroot step. 06:15:02 INFO - Running pre-action listener: _resource_record_pre_action 06:15:02 INFO - Running main action method: populate_webroot 06:15:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:15:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:15:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:15:02 INFO - '--tppagecycles', 06:15:02 INFO - '7'], 06:15:02 INFO - 'tests': ['tsvgm']}}, 06:15:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:15:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:15:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:15:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:15:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:15:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:15:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:15:02 INFO - 'talos_options': ['--disable-e10s'], 06:15:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:15:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:15:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:15:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:15:02 INFO - 'talos_options': ['--disable-e10s'], 06:15:02 INFO - 'tests': ['damp', 'tps']}, 06:15:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:15:02 INFO - 'tests': ['damp', 'tps']}, 06:15:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:15:02 INFO - 'tests': ['dromaeo_dom']}, 06:15:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:15:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:15:02 INFO - 'tests': ['basic_compositor_video']}, 06:15:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:15:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:15:02 INFO - 'tests': ['a11yr', 06:15:02 INFO - 'ts_paint', 06:15:02 INFO - 'tpaint', 06:15:02 INFO - 'sessionrestore', 06:15:02 INFO - 'sessionrestore_no_auto_restore', 06:15:02 INFO - 'tabpaint']}, 06:15:02 INFO - 'other-e10s': {'tests': ['a11yr', 06:15:02 INFO - 'ts_paint', 06:15:02 INFO - 'tpaint', 06:15:02 INFO - 'sessionrestore', 06:15:02 INFO - 'sessionrestore_no_auto_restore', 06:15:02 INFO - 'tabpaint']}, 06:15:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:15:02 INFO - 'ts_paint', 06:15:02 INFO - 'tpaint', 06:15:02 INFO - 'sessionrestore', 06:15:02 INFO - 'sessionrestore_no_auto_restore', 06:15:02 INFO - 'tabpaint']}, 06:15:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:15:02 INFO - 'ts_paint', 06:15:02 INFO - 'tpaint', 06:15:02 INFO - 'sessionrestore', 06:15:02 INFO - 'sessionrestore_no_auto_restore', 06:15:02 INFO - 'tabpaint']}, 06:15:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:15:02 INFO - 'tests': ['a11yr', 06:15:02 INFO - 'ts_paint', 06:15:02 INFO - 'tpaint', 06:15:02 INFO - 'sessionrestore', 06:15:02 INFO - 'sessionrestore_no_auto_restore', 06:15:02 INFO - 'tabpaint']}, 06:15:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:15:02 INFO - 'tests': ['a11yr', 06:15:02 INFO - 'ts_paint', 06:15:02 INFO - 'tpaint', 06:15:02 INFO - 'sessionrestore', 06:15:02 INFO - 'sessionrestore_no_auto_restore', 06:15:02 INFO - 'tabpaint']}, 06:15:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:15:02 INFO - 'tests': ['tsvgx', 06:15:02 INFO - 'tsvgr_opacity', 06:15:02 INFO - 'tart', 06:15:02 INFO - 'tscrollx', 06:15:02 INFO - 'cart']}, 06:15:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:15:02 INFO - 'tsvgr_opacity', 06:15:02 INFO - 'tart', 06:15:02 INFO - 'tscrollx', 06:15:02 INFO - 'cart']}, 06:15:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:15:02 INFO - 'talos_options': ['--disable-e10s'], 06:15:02 INFO - 'tests': ['tp5o']}, 06:15:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:15:02 INFO - 'tests': ['tp5o']}, 06:15:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:15:02 INFO - 'talos_options': ['--disable-e10s', 06:15:02 INFO - '--xperf_path', 06:15:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:15:02 INFO - 'tests': ['tp5n']}, 06:15:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:15:02 INFO - 'talos_options': ['--xperf_path', 06:15:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:15:02 INFO - 'tests': ['tp5n']}}, 06:15:02 INFO - 'talos.zip': {'path': '', 06:15:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:15:02 INFO - Running post-action listener: _resource_record_post_action 06:15:02 INFO - [mozharness: 2016-10-10 13:15:02.187125Z] Finished populate-webroot step (success) 06:15:02 INFO - [mozharness: 2016-10-10 13:15:02.187251Z] Running create-virtualenv step. 06:15:02 INFO - Running pre-action listener: _resource_record_pre_action 06:15:02 INFO - Running main action method: create_virtualenv 06:15:02 INFO - Creating virtualenv /builds/slave/test/build/venv 06:15:02 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:15:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:15:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:15:02 INFO - Using real prefix '/usr' 06:15:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:15:02 INFO - Installing distribute.............................................................................................................................................................................................done. 06:15:04 INFO - Installing pip.................done. 06:15:04 INFO - Return code: 0 06:15:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:15:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:15:04 INFO - Reading from file tmpfile_stdout 06:15:04 INFO - Output received: 06:15:04 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 06:15:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb451f38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c930>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x251dcc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1476104369.968406-649384278', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:15:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:15:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:15:04 INFO - Using env: {'DISPLAY': ':0', 06:15:04 INFO - 'HOME': '/home/cltbld', 06:15:04 INFO - 'LANG': 'en_US.UTF-8', 06:15:04 INFO - 'LANGUAGE': 'en_US:en', 06:15:04 INFO - 'LOGNAME': 'cltbld', 06:15:04 INFO - 'MAIL': '/var/mail/cltbld', 06:15:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:04 INFO - 'MOZ_NO_REMOTE': '1', 06:15:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:04 INFO - 'NO_EM_RESTART': '1', 06:15:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:04 INFO - 'PWD': '/builds/slave/test', 06:15:04 INFO - 'SHELL': '/bin/bash', 06:15:04 INFO - 'SHLVL': '1', 06:15:04 INFO - 'TERM': 'linux', 06:15:04 INFO - 'TMOUT': '86400', 06:15:04 INFO - 'USER': 'cltbld', 06:15:04 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1476104369.968406-649384278', 06:15:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:04 INFO - '_': '/tools/buildbot/bin/python'} 06:15:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:05 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:15:05 INFO - Cleaning up... 06:15:05 INFO - Return code: 0 06:15:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb451f38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c930>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x251dcc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1476104369.968406-649384278', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:15:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:15:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:15:05 INFO - Using env: {'DISPLAY': ':0', 06:15:05 INFO - 'HOME': '/home/cltbld', 06:15:05 INFO - 'LANG': 'en_US.UTF-8', 06:15:05 INFO - 'LANGUAGE': 'en_US:en', 06:15:05 INFO - 'LOGNAME': 'cltbld', 06:15:05 INFO - 'MAIL': '/var/mail/cltbld', 06:15:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:05 INFO - 'MOZ_NO_REMOTE': '1', 06:15:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:05 INFO - 'NO_EM_RESTART': '1', 06:15:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:05 INFO - 'PWD': '/builds/slave/test', 06:15:05 INFO - 'SHELL': '/bin/bash', 06:15:05 INFO - 'SHLVL': '1', 06:15:05 INFO - 'TERM': 'linux', 06:15:05 INFO - 'TMOUT': '86400', 06:15:05 INFO - 'USER': 'cltbld', 06:15:05 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1476104369.968406-649384278', 06:15:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:05 INFO - '_': '/tools/buildbot/bin/python'} 06:15:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:05 INFO - Downloading/unpacking psutil>=3.1.1 06:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:15:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:15:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:15:07 INFO - Installing collected packages: psutil 06:15:07 INFO - Running setup.py install for psutil 06:15:07 INFO - building 'psutil._psutil_linux' extension 06:15:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:15:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:15:07 INFO - building 'psutil._psutil_posix' extension 06:15:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:15:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:15:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:15:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:15:07 INFO - Successfully installed psutil 06:15:07 INFO - Cleaning up... 06:15:07 INFO - Return code: 0 06:15:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:15:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb451f38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c930>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x251dcc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1476104369.968406-649384278', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:15:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:15:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:15:08 INFO - Using env: {'DISPLAY': ':0', 06:15:08 INFO - 'HOME': '/home/cltbld', 06:15:08 INFO - 'LANG': 'en_US.UTF-8', 06:15:08 INFO - 'LANGUAGE': 'en_US:en', 06:15:08 INFO - 'LOGNAME': 'cltbld', 06:15:08 INFO - 'MAIL': '/var/mail/cltbld', 06:15:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:08 INFO - 'MOZ_NO_REMOTE': '1', 06:15:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:08 INFO - 'NO_EM_RESTART': '1', 06:15:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:08 INFO - 'PWD': '/builds/slave/test', 06:15:08 INFO - 'SHELL': '/bin/bash', 06:15:08 INFO - 'SHLVL': '1', 06:15:08 INFO - 'TERM': 'linux', 06:15:08 INFO - 'TMOUT': '86400', 06:15:08 INFO - 'USER': 'cltbld', 06:15:08 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1476104369.968406-649384278', 06:15:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:08 INFO - '_': '/tools/buildbot/bin/python'} 06:15:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:15:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:15:10 INFO - Installing collected packages: mozsystemmonitor 06:15:10 INFO - Running setup.py install for mozsystemmonitor 06:15:10 INFO - Successfully installed mozsystemmonitor 06:15:10 INFO - Cleaning up... 06:15:10 INFO - Return code: 0 06:15:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:15:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb451f38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c930>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x251dcc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1476104369.968406-649384278', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:15:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:15:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:15:10 INFO - Using env: {'DISPLAY': ':0', 06:15:10 INFO - 'HOME': '/home/cltbld', 06:15:10 INFO - 'LANG': 'en_US.UTF-8', 06:15:10 INFO - 'LANGUAGE': 'en_US:en', 06:15:10 INFO - 'LOGNAME': 'cltbld', 06:15:10 INFO - 'MAIL': '/var/mail/cltbld', 06:15:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:10 INFO - 'MOZ_NO_REMOTE': '1', 06:15:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:10 INFO - 'NO_EM_RESTART': '1', 06:15:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:10 INFO - 'PWD': '/builds/slave/test', 06:15:10 INFO - 'SHELL': '/bin/bash', 06:15:10 INFO - 'SHLVL': '1', 06:15:10 INFO - 'TERM': 'linux', 06:15:10 INFO - 'TMOUT': '86400', 06:15:10 INFO - 'USER': 'cltbld', 06:15:10 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1476104369.968406-649384278', 06:15:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:10 INFO - '_': '/tools/buildbot/bin/python'} 06:15:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:10 INFO - Downloading/unpacking jsonschema==2.5.1 06:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:15:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:12 INFO - Downloading functools32-3.2.3-2.tar.gz 06:15:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:15:12 INFO - warning: no files found matching '*.txt' 06:15:12 INFO - no previously-included directories found matching 'build' 06:15:12 INFO - no previously-included directories found matching 'dist' 06:15:12 INFO - no previously-included directories found matching '.git*' 06:15:12 INFO - Installing collected packages: jsonschema, functools32 06:15:12 INFO - Running setup.py install for functools32 06:15:12 INFO - warning: no files found matching '*.txt' 06:15:12 INFO - no previously-included directories found matching 'build' 06:15:12 INFO - no previously-included directories found matching 'dist' 06:15:12 INFO - no previously-included directories found matching '.git*' 06:15:12 INFO - Successfully installed jsonschema functools32 06:15:12 INFO - Cleaning up... 06:15:12 INFO - Return code: 0 06:15:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:15:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb451f38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c930>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x251dcc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1476104369.968406-649384278', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:15:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:15:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:15:12 INFO - Using env: {'DISPLAY': ':0', 06:15:12 INFO - 'HOME': '/home/cltbld', 06:15:12 INFO - 'LANG': 'en_US.UTF-8', 06:15:12 INFO - 'LANGUAGE': 'en_US:en', 06:15:12 INFO - 'LOGNAME': 'cltbld', 06:15:12 INFO - 'MAIL': '/var/mail/cltbld', 06:15:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:12 INFO - 'MOZ_NO_REMOTE': '1', 06:15:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:12 INFO - 'NO_EM_RESTART': '1', 06:15:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:12 INFO - 'PWD': '/builds/slave/test', 06:15:12 INFO - 'SHELL': '/bin/bash', 06:15:12 INFO - 'SHLVL': '1', 06:15:12 INFO - 'TERM': 'linux', 06:15:12 INFO - 'TMOUT': '86400', 06:15:12 INFO - 'USER': 'cltbld', 06:15:12 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1476104369.968406-649384278', 06:15:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:12 INFO - '_': '/tools/buildbot/bin/python'} 06:15:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:15:13 INFO - Cleaning up... 06:15:13 INFO - Return code: 0 06:15:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:15:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb451f38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c930>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x251dcc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1476104369.968406-649384278', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:15:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:15:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:15:13 INFO - Using env: {'DISPLAY': ':0', 06:15:13 INFO - 'HOME': '/home/cltbld', 06:15:13 INFO - 'LANG': 'en_US.UTF-8', 06:15:13 INFO - 'LANGUAGE': 'en_US:en', 06:15:13 INFO - 'LOGNAME': 'cltbld', 06:15:13 INFO - 'MAIL': '/var/mail/cltbld', 06:15:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:13 INFO - 'MOZ_NO_REMOTE': '1', 06:15:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:13 INFO - 'NO_EM_RESTART': '1', 06:15:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:13 INFO - 'PWD': '/builds/slave/test', 06:15:13 INFO - 'SHELL': '/bin/bash', 06:15:13 INFO - 'SHLVL': '1', 06:15:13 INFO - 'TERM': 'linux', 06:15:13 INFO - 'TMOUT': '86400', 06:15:13 INFO - 'USER': 'cltbld', 06:15:13 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1476104369.968406-649384278', 06:15:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:13 INFO - '_': '/tools/buildbot/bin/python'} 06:15:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:13 INFO - Downloading/unpacking blobuploader==1.2.4 06:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:15 INFO - Downloading blobuploader-1.2.4.tar.gz 06:15:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:15:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:15:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:15 INFO - Downloading docopt-0.6.1.tar.gz 06:15:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:15:16 INFO - Installing collected packages: blobuploader, requests, docopt 06:15:16 INFO - Running setup.py install for blobuploader 06:15:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:15:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:15:16 INFO - Running setup.py install for requests 06:15:16 INFO - Running setup.py install for docopt 06:15:16 INFO - Successfully installed blobuploader requests docopt 06:15:16 INFO - Cleaning up... 06:15:16 INFO - Return code: 0 06:15:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:15:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb451f38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c930>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x251dcc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1476104369.968406-649384278', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:15:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:15:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:15:16 INFO - Using env: {'DISPLAY': ':0', 06:15:16 INFO - 'HOME': '/home/cltbld', 06:15:16 INFO - 'LANG': 'en_US.UTF-8', 06:15:16 INFO - 'LANGUAGE': 'en_US:en', 06:15:16 INFO - 'LOGNAME': 'cltbld', 06:15:16 INFO - 'MAIL': '/var/mail/cltbld', 06:15:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:16 INFO - 'MOZ_NO_REMOTE': '1', 06:15:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:16 INFO - 'NO_EM_RESTART': '1', 06:15:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:16 INFO - 'PWD': '/builds/slave/test', 06:15:16 INFO - 'SHELL': '/bin/bash', 06:15:16 INFO - 'SHLVL': '1', 06:15:16 INFO - 'TERM': 'linux', 06:15:16 INFO - 'TMOUT': '86400', 06:15:16 INFO - 'USER': 'cltbld', 06:15:16 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1476104369.968406-649384278', 06:15:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:16 INFO - '_': '/tools/buildbot/bin/python'} 06:15:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:15:16 INFO - Running setup.py (path:/tmp/pip-PUVLAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:15:16 INFO - Running setup.py (path:/tmp/pip-l_F7yU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:15:17 INFO - Running setup.py (path:/tmp/pip-nCm4aC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:15:17 INFO - Running setup.py (path:/tmp/pip-kY6AzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:15:17 INFO - Running setup.py (path:/tmp/pip-jKawYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:15:17 INFO - Running setup.py (path:/tmp/pip-kf3oYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:15:17 INFO - Running setup.py (path:/tmp/pip-SqMHka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:15:17 INFO - Running setup.py (path:/tmp/pip-bG8C1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:15:17 INFO - Running setup.py (path:/tmp/pip-hGLIut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:15:17 INFO - Running setup.py (path:/tmp/pip-6LrVqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:15:17 INFO - Running setup.py (path:/tmp/pip-lbogDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:15:17 INFO - Running setup.py (path:/tmp/pip-0SCXeV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:15:17 INFO - Running setup.py (path:/tmp/pip-DgsXBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:15:17 INFO - Running setup.py (path:/tmp/pip-PRM6gb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:15:17 INFO - Running setup.py (path:/tmp/pip-vN0LHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:15:17 INFO - Running setup.py (path:/tmp/pip-QfJZES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:15:18 INFO - Running setup.py (path:/tmp/pip-bp2bUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:15:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:15:18 INFO - Running setup.py install for manifestparser 06:15:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:15:18 INFO - Running setup.py install for mozcrash 06:15:18 INFO - Running setup.py install for mozdebug 06:15:18 INFO - Running setup.py install for mozdevice 06:15:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:15:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:15:18 INFO - Running setup.py install for mozfile 06:15:18 INFO - Running setup.py install for mozhttpd 06:15:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:15:18 INFO - Running setup.py install for mozinfo 06:15:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:15:18 INFO - Running setup.py install for mozInstall 06:15:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:15:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:15:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:15:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:15:18 INFO - Running setup.py install for mozleak 06:15:19 INFO - Running setup.py install for mozlog 06:15:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:15:19 INFO - Running setup.py install for moznetwork 06:15:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:15:19 INFO - Running setup.py install for mozprocess 06:15:19 INFO - Running setup.py install for mozprofile 06:15:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:15:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:15:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:15:19 INFO - Running setup.py install for mozrunner 06:15:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:15:19 INFO - Running setup.py install for mozscreenshot 06:15:19 INFO - Running setup.py install for moztest 06:15:19 INFO - Running setup.py install for mozversion 06:15:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:15:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:15:19 INFO - Cleaning up... 06:15:19 INFO - Return code: 0 06:15:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:15:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb451f38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c930>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x251dcc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1476104369.968406-649384278', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:15:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:15:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:15:19 INFO - Using env: {'DISPLAY': ':0', 06:15:19 INFO - 'HOME': '/home/cltbld', 06:15:19 INFO - 'LANG': 'en_US.UTF-8', 06:15:19 INFO - 'LANGUAGE': 'en_US:en', 06:15:19 INFO - 'LOGNAME': 'cltbld', 06:15:19 INFO - 'MAIL': '/var/mail/cltbld', 06:15:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:19 INFO - 'MOZ_NO_REMOTE': '1', 06:15:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:19 INFO - 'NO_EM_RESTART': '1', 06:15:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:19 INFO - 'PWD': '/builds/slave/test', 06:15:19 INFO - 'SHELL': '/bin/bash', 06:15:19 INFO - 'SHLVL': '1', 06:15:19 INFO - 'TERM': 'linux', 06:15:19 INFO - 'TMOUT': '86400', 06:15:19 INFO - 'USER': 'cltbld', 06:15:19 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1476104369.968406-649384278', 06:15:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:19 INFO - '_': '/tools/buildbot/bin/python'} 06:15:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:15:20 INFO - Running setup.py (path:/tmp/pip-P__ID1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:15:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:15:20 INFO - Running setup.py (path:/tmp/pip-1_Cdbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:15:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:15:20 INFO - Running setup.py (path:/tmp/pip-TKVi5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:15:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:15:20 INFO - Running setup.py (path:/tmp/pip-mldlQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:15:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:15:20 INFO - Running setup.py (path:/tmp/pip-36iWsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:15:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:15:20 INFO - Running setup.py (path:/tmp/pip-mLIoiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:15:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:15:20 INFO - Running setup.py (path:/tmp/pip-dRMwQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:15:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:15:20 INFO - Running setup.py (path:/tmp/pip-VfGfXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:15:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:15:20 INFO - Running setup.py (path:/tmp/pip-kVyCJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:15:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:15:20 INFO - Running setup.py (path:/tmp/pip-60hMCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:15:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:15:20 INFO - Running setup.py (path:/tmp/pip-NUUrvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:15:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:15:20 INFO - Running setup.py (path:/tmp/pip-NCww5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:15:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:15:21 INFO - Running setup.py (path:/tmp/pip-xobqTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:15:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:15:21 INFO - Running setup.py (path:/tmp/pip-Rn0vtE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:15:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:15:21 INFO - Running setup.py (path:/tmp/pip-rI0z36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:15:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:15:21 INFO - Running setup.py (path:/tmp/pip-rVkVqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:15:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:15:21 INFO - Running setup.py (path:/tmp/pip-x93BeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:15:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:15:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:15:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:15:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:15:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:15:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:15:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:15:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:23 INFO - Downloading blessings-1.6.tar.gz 06:15:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:15:23 INFO - Installing collected packages: blessings 06:15:23 INFO - Running setup.py install for blessings 06:15:23 INFO - Successfully installed blessings 06:15:23 INFO - Cleaning up... 06:15:23 INFO - Return code: 0 06:15:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:15:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:15:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:15:23 INFO - Reading from file tmpfile_stdout 06:15:23 INFO - Current package versions: 06:15:23 INFO - argparse == 1.2.1 06:15:23 INFO - blessings == 1.6 06:15:23 INFO - blobuploader == 1.2.4 06:15:23 INFO - docopt == 0.6.1 06:15:23 INFO - functools32 == 3.2.3-2 06:15:23 INFO - jsonschema == 2.5.1 06:15:23 INFO - manifestparser == 1.1 06:15:23 INFO - mozInstall == 1.12 06:15:23 INFO - mozcrash == 0.17 06:15:23 INFO - mozdebug == 0.1 06:15:23 INFO - mozdevice == 0.48 06:15:23 INFO - mozfile == 1.2 06:15:23 INFO - mozhttpd == 0.7 06:15:23 INFO - mozinfo == 0.9 06:15:23 INFO - mozleak == 0.1 06:15:23 INFO - mozlog == 3.4 06:15:23 INFO - moznetwork == 0.27 06:15:23 INFO - mozprocess == 0.23 06:15:23 INFO - mozprofile == 0.28 06:15:23 INFO - mozrunner == 6.12 06:15:23 INFO - mozscreenshot == 0.1 06:15:23 INFO - mozsystemmonitor == 0.3 06:15:23 INFO - moztest == 0.7 06:15:23 INFO - mozversion == 1.4 06:15:23 INFO - psutil == 3.1.1 06:15:23 INFO - requests == 1.2.3 06:15:23 INFO - wsgiref == 0.1.2 06:15:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:15:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb451f38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c930>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x251dcc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1476104369.968406-649384278', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:15:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:15:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:15:23 INFO - Using env: {'DISPLAY': ':0', 06:15:23 INFO - 'HOME': '/home/cltbld', 06:15:23 INFO - 'LANG': 'en_US.UTF-8', 06:15:23 INFO - 'LANGUAGE': 'en_US:en', 06:15:23 INFO - 'LOGNAME': 'cltbld', 06:15:23 INFO - 'MAIL': '/var/mail/cltbld', 06:15:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:23 INFO - 'MOZ_NO_REMOTE': '1', 06:15:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:23 INFO - 'NO_EM_RESTART': '1', 06:15:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:23 INFO - 'PWD': '/builds/slave/test', 06:15:23 INFO - 'SHELL': '/bin/bash', 06:15:23 INFO - 'SHLVL': '1', 06:15:23 INFO - 'TERM': 'linux', 06:15:23 INFO - 'TMOUT': '86400', 06:15:23 INFO - 'USER': 'cltbld', 06:15:23 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1476104369.968406-649384278', 06:15:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:23 INFO - '_': '/tools/buildbot/bin/python'} 06:15:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:15:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:15:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:15:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:15:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:15:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:15:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:15:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:15:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:15:23 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:15:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:15:23 INFO - Cleaning up... 06:15:23 INFO - Return code: 0 06:15:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:15:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb451f38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c930>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x251dcc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1476104369.968406-649384278', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:15:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:15:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:15:23 INFO - Using env: {'DISPLAY': ':0', 06:15:23 INFO - 'HOME': '/home/cltbld', 06:15:23 INFO - 'LANG': 'en_US.UTF-8', 06:15:23 INFO - 'LANGUAGE': 'en_US:en', 06:15:23 INFO - 'LOGNAME': 'cltbld', 06:15:23 INFO - 'MAIL': '/var/mail/cltbld', 06:15:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:23 INFO - 'MOZ_NO_REMOTE': '1', 06:15:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:23 INFO - 'NO_EM_RESTART': '1', 06:15:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:23 INFO - 'PWD': '/builds/slave/test', 06:15:23 INFO - 'SHELL': '/bin/bash', 06:15:23 INFO - 'SHLVL': '1', 06:15:24 INFO - 'TERM': 'linux', 06:15:24 INFO - 'TMOUT': '86400', 06:15:24 INFO - 'USER': 'cltbld', 06:15:24 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1476104369.968406-649384278', 06:15:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:24 INFO - '_': '/tools/buildbot/bin/python'} 06:15:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:15:24 INFO - Cleaning up... 06:15:24 INFO - Return code: 0 06:15:24 INFO - Running post-action listener: _resource_record_post_action 06:15:24 INFO - Running post-action listener: _start_resource_monitoring 06:15:24 INFO - Starting resource monitoring. 06:15:24 INFO - [mozharness: 2016-10-10 13:15:24.246266Z] Finished create-virtualenv step (success) 06:15:24 INFO - [mozharness: 2016-10-10 13:15:24.246776Z] Running install step. 06:15:24 INFO - Running pre-action listener: _resource_record_pre_action 06:15:24 INFO - Running main action method: install 06:15:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:15:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:15:24 INFO - Reading from file tmpfile_stdout 06:15:24 INFO - Detecting whether we're running mozinstall >=1.0... 06:15:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:15:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:15:24 INFO - Reading from file tmpfile_stdout 06:15:24 INFO - Output received: 06:15:24 INFO - Usage: mozinstall [options] installer 06:15:24 INFO - Options: 06:15:24 INFO - -h, --help show this help message and exit 06:15:24 INFO - -d DEST, --destination=DEST 06:15:24 INFO - Directory to install application into. [default: 06:15:24 INFO - "/builds/slave/test"] 06:15:24 INFO - --app=APP Application being installed. [default: firefox] 06:15:24 INFO - mkdir: /builds/slave/test/build/application 06:15:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:15:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:15:41 INFO - Reading from file tmpfile_stdout 06:15:41 INFO - Output received: 06:15:41 INFO - /builds/slave/test/build/application/firefox/firefox 06:15:41 INFO - Running post-action listener: _resource_record_post_action 06:15:41 INFO - [mozharness: 2016-10-10 13:15:41.558802Z] Finished install step (success) 06:15:41 INFO - [mozharness: 2016-10-10 13:15:41.559050Z] Running run-tests step. 06:15:41 INFO - Running pre-action listener: _resource_record_pre_action 06:15:41 INFO - Running main action method: run_tests 06:15:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:15:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:15:41 INFO - Python 2.7.3 06:15:41 INFO - Return code: 0 06:15:41 INFO - grabbing minidump binary from tooltool 06:15:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:41 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251c930>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x251dcc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:15:41 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:15:41 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:15:41 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:15:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:15:41 INFO - Return code: 0 06:15:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:15:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:15:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:15:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:15:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:15:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Rhc8FJFoTrCs83uThm9E3A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:15:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Rhc8FJFoTrCs83uThm9E3A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:15:41 INFO - Using env: {'DISPLAY': ':0', 06:15:41 INFO - 'HOME': '/home/cltbld', 06:15:41 INFO - 'LANG': 'en_US.UTF-8', 06:15:41 INFO - 'LANGUAGE': 'en_US:en', 06:15:41 INFO - 'LOGNAME': 'cltbld', 06:15:41 INFO - 'MAIL': '/var/mail/cltbld', 06:15:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:15:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:15:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:41 INFO - 'MOZ_NO_REMOTE': '1', 06:15:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:15:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:41 INFO - 'NO_EM_RESTART': '1', 06:15:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:41 INFO - 'PWD': '/builds/slave/test', 06:15:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:15:41 INFO - 'SHELL': '/bin/bash', 06:15:41 INFO - 'SHLVL': '1', 06:15:41 INFO - 'TERM': 'linux', 06:15:41 INFO - 'TMOUT': '86400', 06:15:41 INFO - 'USER': 'cltbld', 06:15:41 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1476104369.968406-649384278', 06:15:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:41 INFO - '_': '/tools/buildbot/bin/python'} 06:15:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Rhc8FJFoTrCs83uThm9E3A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:15:41 INFO - mozversion application_buildid: 20161010043001 06:15:41 INFO - mozversion application_changeset: 7be6b348c431d69f96f0765af3a0c0a0fe56d4bf 06:15:41 INFO - mozversion application_display_name: Nightly 06:15:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:15:41 INFO - mozversion application_name: Firefox 06:15:41 INFO - mozversion application_remotingname: firefox 06:15:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:15:41 INFO - mozversion application_vendor: Mozilla 06:15:41 INFO - mozversion application_version: 52.0a1 06:15:41 INFO - mozversion platform_buildid: 20161010043001 06:15:41 INFO - mozversion platform_changeset: 7be6b348c431d69f96f0765af3a0c0a0fe56d4bf 06:15:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:15:41 INFO - mozversion platform_version: 52.0a1 06:15:41 INFO - using testdate: 1476105341 06:15:41 INFO - actual date: 1476105341 06:15:41 INFO - starting webserver on 'localhost:36751' 06:15:41 INFO - SUITE-START | Running 2 tests 06:15:41 INFO - TEST-START | dromaeo_css 06:15:41 INFO - operating with platform_type : linux_ 06:15:41 INFO - Initialising browser for dromaeo_css test... 06:15:41 INFO - TEST-INFO | started process 11570 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsQtznK/profile http://localhost:36751/getInfo.html) 06:15:46 INFO - PROCESS | 11570 | __metrics Screen width/height:1600/1200 06:15:46 INFO - PROCESS | 11570 | colorDepth:24 06:15:46 INFO - PROCESS | 11570 | Browser inner width/height: 1024/697 06:15:46 INFO - PROCESS | 11570 | __metrics 06:15:46 INFO - PROCESS | 11570 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:15:46 INFO - PROCESS | 11570 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:15:47 INFO - PROCESS | 11570 | console.error: PushService: 06:15:47 INFO - PROCESS | 11570 | stateChangeProcessEnqueue: Error transitioning state 06:15:47 INFO - PROCESS | 11570 | UnknownError 06:15:47 INFO - TEST-INFO | 11570: exit 0 06:15:47 INFO - Browser initialized. 06:15:47 INFO - Running cycle 1/1 for dromaeo_css test... 06:15:47 INFO - TEST-INFO | started process 11653 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsQtznK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:16:00 INFO - PROCESS | 11653 | RSS: Main: 173101056 06:16:00 INFO - PROCESS | 11653 | 06:16:51 INFO - PROCESS | 11653 | 1476105411427 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:19:01 INFO - PROCESS | 11653 | Cycle 1(1): loaded http://localhost:36751/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36751/tests/dromaeo/cssquery-ext.html) 06:19:03 INFO - PROCESS | 11653 | RSS: Main: 326889472 06:19:03 INFO - PROCESS | 11653 | 06:22:06 INFO - PROCESS | 11653 | Cycle 1(1): loaded http://localhost:36751/tests/dromaeo/cssquery-ext.html (next: http://localhost:36751/tests/dromaeo/cssquery-jquery.html) 06:22:06 INFO - PROCESS | 11653 | RSS: Main: 279007232 06:22:06 INFO - PROCESS | 11653 | 06:25:08 INFO - PROCESS | 11653 | Cycle 1(1): loaded http://localhost:36751/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36751/tests/dromaeo/cssquery-mootools.html) 06:25:09 INFO - PROCESS | 11653 | RSS: Main: 215232512 06:25:09 INFO - PROCESS | 11653 | 06:28:11 INFO - PROCESS | 11653 | Cycle 1(1): loaded http://localhost:36751/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36751/tests/dromaeo/cssquery-prototype.html) 06:28:11 INFO - PROCESS | 11653 | RSS: Main: 213512192 06:28:11 INFO - PROCESS | 11653 | 06:31:14 INFO - PROCESS | 11653 | Cycle 1(1): loaded http://localhost:36751/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36751/tests/dromaeo/cssquery-yui.html) 06:31:15 INFO - PROCESS | 11653 | RSS: Main: 215121920 06:31:15 INFO - PROCESS | 11653 | 06:34:18 INFO - PROCESS | 11653 | Cycle 1(1): loaded http://localhost:36751/tests/dromaeo/cssquery-yui.html (next: http://localhost:36751/tests/dromaeo/cssquery-dojo.html) 06:34:18 INFO - PROCESS | 11653 | RSS: Main: 305274880 06:34:18 INFO - PROCESS | 11653 | 06:34:18 INFO - PROCESS | 11653 | __start_tp_report 06:34:18 INFO - PROCESS | 11653 | _x_x_mozilla_page_load 06:34:18 INFO - PROCESS | 11653 | _x_x_mozilla_page_load_details 06:34:18 INFO - PROCESS | 11653 | |i|pagename|runs| 06:34:18 INFO - PROCESS | 11653 | |0;dojo.html;2980.4039192161567;3016.622922134733;3018.683038280979;3041.8631161597727;3046.801957872738;5109.310243117178;5141.331626888504;5175.120229560975;5197.792088316468;5220.086484865153;5171.534561889429;5207.9739601302035;5208.713520756357;5223.529882310591;5233.031889100519;4696.53034696531;4770.785314660831;4778.307145463906;4801.0157917626975;4810.06203790261;4677.462091859428;4737.360456338385;4748.050389922012;4781.928271075919;4789.114013907439;4735.337052812609;4740.715557066587;4761.880952976168;4766.833160839354;4824.228123500241;4621.930671039937;4652.906941861143;4701.130290896195;4734.692245004064;4743.24108142699;4567.132244873464;4576.427946506687;4600.930986035212;4610.631149508032;4667.649926255511;5049.469805670388;5062.493750624945;5065.39215294167;5079.034983353151;5141.640085194038;5366.973165134149;5528.502434780889;5529.751161197756;5535.280413546254;5539.8892022159735;5443.2107344434835;5510.256115424407;5513.448655134494;5567.081431563787;5622.072358060915;5175.223716442564;5184.14461613837;5185.455527169668;5186.014657215117;5187.662801917863;5665.915011274834;5670.943290567124;5673;5680.233168522279;5743.85640358986;5217.2434996925995;5236.476352364809;5390.434004429479;5433.782648694087;5446.618736688394;5523.033469142884;5524.06090964537;5525.530329921921;5529.30883639545;5586.050371436865;5452.263944367539;5495.53287970519;5495.862603434866;5508.228847961289;5515.310586176728;5371.650842695212;5412.83761487156;5415.48552887475;5466.3440387153005;5572.136318870582;4282.678799090081;4284;4285.014446677282;4288.18524480354;4289.206496798102;3858.6527212551005;3876.3604005339366;3878.5345758508597;3880.3791393376923;3881.7088718346236;5219.269302297681;5224.05966925957;5225.686458812484;5228.738563071831;5228.9477105229225;5473.261109750133;5518.972405137949;5527.778888844482;5537.003339398947;5538.695371754511;5251.36983561975;5259.605529585297;5279.683219006872;5283.049051170749;5284.762185701576;4825.6139508839915;4826.0589185108565;4841.927371089437;4853.4418541868135;4855.878603034952;5801.680907550125;5806.274215723035;5806.9419305806405;5813.76744930198;5837.09525023622;5376.247325374529;5430.619856609999;5622.550195984393;5634.408387119293;5707.800226992035;5669.659820410789;5683.943160568341;5689.345725241485;5707.143928410772;5783.248177736868;5432.565394768488;5434.945650543444;5435.510804027656;5436.483534064258;5439.456054394529;5359.222912677717;5534.363548192009;5539.252564607163;5539.944600553943;5603.80386686464;5279.313689220377;5334.06653835585;5351;5383.353997520323;5428.131498960148;5361.892762144813;5365.034293827149;5370.543503802221;5370.677759334452;5373.919391209057;5351.438098999549;5361.986229918638;5365.865853353697;5385.649932754359;5432.456754324536;5288.074586947346;5321.30822993024;5380.623356365017;5448.073827449264;5500.367457742411;5341.118715412069;5343.198520221998;5386.7575959082715;5401.216823560483;5403.13549832025 06:34:18 INFO - PROCESS | 11653 | |1;ext.html;540.8344723189748;589.4076453164569;593.6378808926556;599.3616798110013;612.2775125352084;31683.207919802015;32412;42774.786126069324;43837.465688700904;43974;40617.79691101548;44715.552844471546;44757.328640070424;44792;44793.104137917304;8898.421602595827;9051.909480905206;9059.637614495412;9062.954685226598;9064.410813297147;8123.350131989456;8353.707620233294;8827.117288271154;10569.41868197249;10867.076298514596;10986.285891417072;11081.451266208776;11087.55649774012;11089;11090.778184436307;10844;10895.400752958583;10897.618583349624;10905.83641245382;10910.890891091067;10642.467876606139;10665.893341066567;10694.572217111307;10695.251332406735;10723.517441715141;42623.78688106571;42657.57342426567;43000.35499467511;43120.13759724819;43128.353074703904;3488.284901595167;3608.2061946371755;3999.2201520703475;4155.91688166235;4217.451731274915;32079.358412831847;32186.678133218837;32194;32296.677033229604;32434.18914527132;4134.524529679095;4193.685473589493;4241.36379543068;4289.440345778362;4311.762853043081;338683;338782;341162.9999999975;341363;341549;58189.70905145447;58305.416945830846;58453.41546584565;58724.238272851886;58736.41263587395;62035.6898215506;62040.68979655073;62199;62201.68899155475;62206;16501.174941252888;16662.750058749127;16663.3334666612;16673.33306667744;16678.83321166797;12358.814617780741;13427.798583021262;13459.327033648278;13481.393337299845;13484.056116071977;14891.18098504571;16668.49994500167;17192.140392980553;17440;17659.73510397345;6275.874482510324;6340.239171299381;6367.681615919186;6398.328175541595;6621.086721842374;963.3930623707159;1035.6634093919506;1058.3861360410942;1068.9251752377259;1076.1605947360915;31406.528902066486;32285.838570806995;32399.190020249684;32712;32818.50772238418;1042.9739256518649;1098.4562641492353;1111.3220935229504;1120.991108002804;1211.1642966353188;16529.917350413172;17097;17294.827051729575;17479.563010924827;17805.883970305145;470125;472739;473176;474473;474576;58441;58514.41485585175;58635.70682146562;58697.119543206885;58729.70635146883;1118.7706520163347;1176.3358284402386;1274.26729630461;1309.1817613991254;1345.724126554054;30149.851047161053;33515.83242083774;33539.83230083834;33582.328353432305;33898.8305058483;49712.502874970785;50293.74853125711;50426.7478662619;50468.242976356116;50474.74762626163;402720;404400;406399;406452;407395;27059.72940270572;27587.862060689567;28097.57853632238;28364.43271134607;28913.855430722713;47988.04023919572;48319.51680483291;48415.5158448411;48825.267620985;49055;39128.804355978034;40670.59329406786;40933.79533102315;41213.79393103015;42402;39930;40730.59269407268;41396.37905431481;41438.378424323055;41793;39661;39685.404718928665;40197.397039043855;40611.593884061964;40642.79678601588;33680.32639347248;35736;36366.63633363633;36530.634693652726;36566.817165914;27686.44627107487;27771.166864994084;28111.859440702665;28176.436471270048;28229.576556352084 06:34:18 INFO - PROCESS | 11653 | |2;jquery.html;378.27182673353786;396.17397725741824;405.525535123905;410.41925675169637;417.3781066211346;13022.934885325572;14973.326200320984;18288.26846926123;18661.906690466563;19272.229110835586;18413.53966150847;18699.626007479877;19065.809341906577;19082;19362.709559356586;5459.781608735656;5498.972505137489;5720.9713951430185;5722.399148089453;5725.685087320217;5574.777008919658;5586.944130558703;5628.915566266509;5631.0708733059;5669.09294512878;5396.757145928423;5592.384837667873;5596.552275817925;5598.776048958037;5600.355959064698;5541.501264886159;5578.0517312056845;5580.525655319303;5618.6628802272;5622.128570071645;4833;5014.34813474246;5076.162433198518;5078.669886457368;5079.314292570492;22502.21242256513;22542;22549.77450225493;22638.77361226383;22731.431714207112;2391.9521609567887;2438.3538362333998;2439.316991242455;2456.459578892641;3042.6196725409322;14053.367598457991;14098.436062557485;14207.153070100923;14334.21161836109;14435.350409231505;1883.6138591588829;1933.4103098554936;1974.575466274758;1999.4701404127918;2041.8774873507637;83295.16704832995;83845;84722.57638711829;84750.57624711898;86898;10493.213009024354;10522.894771052344;10562.419066951237;10781.299215550964;10815.459227038617;14793.63015924589;14894.404223830925;15086.622834429227;15118.168500732565;15130.167840768643;7945.761627151194;7967.8406431871035;8365.832683346422;8621.741347759576;8626.698065567674;8119.431639785158;8322.62548185321;8323;8434.409591328671;8570.914290857012;6239.532035097386;6432.42108210254;6486;6541.705623246965;6556.672166391661;1803.2606631281112;1922.1158267196965;1936.244864502845;1943.2906988948932;1989.9602007959759;833.9166083391613;968.8934217236099;979.7060881735451;1024.538957469142;1027.9640212592524;18187.727184092248;19806.801931980783;19881.30415435453;19891.801081989284;20336.593268134555;1023.99488002561;1036.404067661098;1039.896010398954;1068.6793961811425;1103.3049179017169;10014.693681716786;11264.380459074666;11355.943220283845;11421.771564568662;11423.942880285545;418481;422544;461856;465326;470340;94842;96708.51645741866;97373.51313243389;99168.50415747875;99550.5022474883;1009.5204777730519;1041.5469270867197;1067.2422579968309;1070.29895418501;1071.796358691846;17037.48887533376;17320.91339543294;17439.738403923697;17495.49252583335;17977.191026403583;40890.591094088675;41147.58852411438;41802;43010;44035.55964440443;53184;56683.716581416826;57254.14118788138;57687.423125769885;57877.369810415905;8107.1892810718455;8321.646092166511;8473.152684731724;8728.69449569262;8891.155340242667;12416.503339866304;12471.5011399543;12716.173448726173;12723.745525089262;13354.532591359644;11032.558697652004;11623.07015438746;11687.415629218334;11714;12023.158378913393;11064;11082.556697732323;11090.223684342018;11149.609763658233;11233.831492527783;10877.782444351227;11249.831252531056;11628.127890408423;11677.124215684027;11932.522699091938;7057.7176912922905;7627.8855817161675;8262.752117436487;8446.873296900429;8712.69505567302;10392.428416436866;11146.219764616399;11166.330020198815;11311.886881131084;11753.412329383667 06:34:18 INFO - PROCESS | 11653 | |3;mootools.html;1338.2840180503433;1434.153849228955;1465.2746890289307;1619.2794206578071;1757.9824201757986;7827.2955434011;8630.91369086309;8924.732258032253;8937.776555586106;9179.31155163362;8896.243819275369;8981.416207946495;8985.505797181153;8986.820263594724;8992.145746154105;2294.3919861236745;2361.8346715729904;2366.065404165354;2377.643353496972;2391.533650938059;2329.406001469623;2358.41039740065;2360.7875291223786;2372.264597974625;2386.8090552755825;2325.2442956039354;2325.744168141503;2348.295511346598;2380.5357955198742;2384.701912260967;2303.285981345788;2330.976690233101;2338.1465764995824;2339.415146213447;2354.5173239485866;2251.313349428424;2265.524239909621;2274.590573696734;2287.6911616931666;2291.0721157931066;8811.162939520735;8893.155150260714;8900.777480562972;8903.866442003375;8903.955480222623;5226.111561034633;5403.297571315704;5405.972970135124;5481.369642491125;5482.369527504348;3433.1588760753525;3446.3968805459194;3468.271662950783;3501.404761190578;3520.137566296248;1069.6363236499549;1077.5635867473686;1098.4435411916281;1106.1206340958877;1115.0800589513683;11945.104117191246;11970.760584788255;12062.698432539257;12089.6373108806;12089.758204835942;4340.674449416243;4455.086707225011;4636.513166117509;4637.165310244189;4641.907161856811;9517.381370210915;9527.237820974306;9544.904550954541;9552.235821134293;9567.091126342986;5280.762365693553;5290.365156181206;5295.443978382292;5295.629305948547;5298.655587386807;4306.935395969063;4317.546657600969;4331.935020974688;4472.731636101845;4949.505049495022;3600.261946301002;3912.882613521599;3919.0986073202753;3931.4495970564144;3937.940930886039;1079.5573814735922;1090.5637744901944;1106.502074066657;1107.2028139739375;1113.8774734779167;888.1030159538913;914.9130832570895;932.2402242172608;937.6952490440498;957.7892863570142;5654.434556544395;5740.339860916049;5867.70661466925;6119.173911521976;6399.9360006400275;956.8756061711933;990.5245482168599;1000.9399436033862;1035.6323505155713;1045.811753884293;3810.7713537187856;3933.5083114610675;3968.980155099206;3974.701897357652;4017.2367250222364;10665.466726663792;11061.944690276498;11077.778444431227;11084.833727494093;11131.499082541304;10927;11022.44887755609;11035.503402346914;11119.777604447865;11134.721631959266;7233.493655444068;7538.170801211862;7543.47195696296;7707.306342429209;7865.056193256732;5568.765360561059;5817.94182058174;5839.0949402842625;5942.405759424023;6061.272427407773;9777.071178238057;9861.950690246504;9910.15763660097;10048.145907597644;10106.090451859369;8447.155284471504;10195.694129176136;10262.743431413975;10338.172946164439;10482.161427085663;7198.71205151788;7649.541027538366;7826.530408175528;7879.724209652634;8070.515769053875;8399.664013439395;8516.957415212884;8544.18830211129;8579.14208579137;8646.56767161652;7660.961695191489;7692.38460923136;7711.922880771121;7815.648295826815;7932.127465978622;7675.577843218676;7692.499987500794;7702.499337543042;7727.690892364468;7858.489198202098;6573.704183311858;6607.537472376887;6707.698153583003;6791.456683465212;6801.591904485746;4879;4890.095332363524;4932.8026878925875;4976.129177394014;5071.92392114126;4873.220284754422;4887.853364399074;5010.724410157476;5011.09800235961;5077.2637967493765 06:34:18 INFO - PROCESS | 11653 | |4;prototype.html;328.998355008225;336.5322202139027;341.57473944938556;349.067988470783;350.93858574749413;5266.789328426863;5270.604704647148;5271.499207575283;5272.209168624709;5309.575233981282;4877.292792545088;5235.397929238139;5238.188080847465;5248.5276325130735;5259.158534634459;3972.920541589181;3997.9005773412255;4057.9710144927535;4069.837206511736;4076.9388459173138;4038.9094944365006;4051.9594804052026;4053;4058.898527536806;4065.552789193201;3881.243157584272;4026.6711985044867;4034.354503279476;4043.818028188724;4045.1505183911413;3953.802309884494;3984.6812255019527;3997.5802540733093;4036.777977211252;4067.715259931806;3597.4963505109304;3602.9279414411567;3604.441311596707;3623.9275214495824;3627.292677927805;5068.543831055223;5084.084864724348;5115.5396014358885;5116;5144.6655967362;4560.612347950429;4667.416572928384;4678.812847486097;4685.273782563708;4703.553162449562;5366.597505187087;5377.677339359612;5384.434634363374;5395.570173903919;5411.64824286424;4006.939895901564;4014.8594799181888;4037.212743515016;4038.6365227129404;4046.534648515429;5346.144616861284;5545.694986775726;5625.915611265835;5637.463141586261;5677.716114194273;4094.549599544048;4125.29869922114;4126.174765047002;4134.193832202752;4152.5432202457705;4203.957960420356;4210.452641156691;4211.810468528924;4215.882791060371;4219.662427005832;4455.6212721918355;4662.510436404129;4721.362616046858;4747.667663263538;4749.311349854252;5442.401335853053;5443.129099344086;5445.891082178414;5447.809326673548;5465.672059676433;1444.5016469318068;1458;1460.992695036518;1463.1294379843976;1474.9336279867432;918.3066784577735;945.3288165402641;954.3176628710366;965.7971825916636;976.2239019978991;5079.6952182869145;5117.820876269313;5253.159494480865;5273;5286.60350473716;5560.749766260528;5588.357338905997;5605.7197140142825;5618.71305286412;5633.985817587571;5051.292819005343;5333.439988801198;5343.732813359316;5346.5455436287575;5381.165919282517;2948.4545359108633;2991.2949618717557;2996.9700302997126;2998.7151220634005;3004.369082492701;5817.185594016841;5834.591578589458;5835.416458354131;5857.648541087463;5878.911816322673;5599.636023658449;5731.828045158652;5743.798967036134;5744.597878148573;5759.164921086419;5805.332386775491;5810.680412577349;5816.27296587935;5818.592698511148;5829.650220986754;5258.710770907637;5511.22842802;5635.393912734851;5676.318841739017;5686.658800471985;5475.206095116266;5483.890322193613;5537.9169312459535;5544.891021795576;5564.527015203753;5715.028445164249;5732.828015159552;5759.827205183851;5780.768769249351;5834.708264586839;3649.8685407523753;3679.2457546202427;3837.788921609338;4043.73715708478;4053.452783874139;5574.804881829116;5583.832485025293;5592.161175823497;5596.4123767003875;5596.468335508121;5470.480304371078;5473.452654734495;5485.670859748428;5485.820548582074;5503.229547863382;5204.765785539736;5389.514943654933;5405.189221616789;5438.374586922397;5456.918146227889;5422.972885135707;5432.565394768488;5461.481159289861;5479.424660410599;5489.478499542537;5267.657602255841;5306.681599104066;5366.275552800478;5458.590605704668;5477.616566840283;5342.278792362981;5355.25026496283;5359.490848369399;5362.3833259174135;5369.167778994262 06:34:18 INFO - PROCESS | 11653 | |5;yui.html;671.7951024937394;688.1123350877367;698.2528694297101;812.2162113560421;831.0858056138253;13233.404496797642;14008.509702160427;14026.859731402683;14039.438422463101;14099.295035248248;13235.139715918483;13356.465741370333;13466.528671496475;13789.586312410618;13951.720965580682;803.6825453945688;823.2878560045548;824.6660102658403;824.9628766705513;825.8761185822144;668.6355936014859;692.2558249881372;789.3645615279697;822.9341652667772;825.6119623776815;860.7805009722512;875.264777586827;875.7460336502406;877.394597727566;878.4377998081233;866.4194989357146;867.3364875869964;868.3660927522913;868.7437206024238;868.7567481105301;503.6172508893231;519.1771042897013;601.9337872833985;629.625372903122;636.7994081864198;12693.682657933534;13227;13227.86772132276;13233.867661323457;13240.801387979189;13208.86791132086;13917.652058698613;14148.717025659533;14177.85822141786;14183.78724319136;12347.876521234852;12609.93695031519;12755.808662870064;12863.678408039874;13101.868981310256;4312.202242585132;4347.978260108711;4401.977990110061;4402.44690903666;4419.005723712171;74174;74383.25616743817;74422.62788686076;76376.85434718429;77484.61257693732;10636.521356538975;10836.891631083747;11157.776844463227;11161.776764464665;11209.607663731731;20397.38807835767;20403;20429.591408171753;20459.795402046086;20516.281930132373;8067.878981815277;8077.5961201940845;8181.345492360597;8220.712275070344;8336.541490217975;4409.162259170747;4450.1767173073085;4527.7736113194205;4546.74992875395;4590.196715574761;3405.506201600754;3484.8954531364097;3495.9825200874343;3505.9123521912156;3512.438009918401;615.2678312807744;623.1649589550025;628.2649300318639;631.2897989761518;632.4529282170981;640.3948268885952;642.8135840606266;670.1689904518362;680.9455243580601;685.2325395557008;7625.847483050419;8469.195426434479;8642.265407440313;8701.521416322037;8725.301975841918;471.3424772442424;584.9208210850973;591.2284468768298;594.7323704333068;646.6023395611664;4007.519097708235;4292.325433950175;4335.9349609755245;4378.824847006148;4413.58070983256;71141.64429177821;71789.2821071793;72074.99062617173;100224;117249;101004;101009;104489;105413;109473;71702.99999999895;90921.54539227394;92704;93124.53437732768;94195;9191.816163676824;9307.581158847732;9828.803423931624;9955.20358371343;10014.749631258985;47271.29093063676;48847;50268;51270.48729512657;51863.22205167001;47704.2844357328;48604.756976216304;49278.50721492739;70187.29812702011;71354;11966.282023078644;12118.394080295773;12657;12840;13111.2133272004;14082.653198586182;14348.856511434751;14382.640433989234;14483.20342381137;15397.153156576496;12515.436805343963;12988.610341689764;13121.343932803513;13560.59318220455;13953.581392558239;12492.188007779465;12604.432800524182;13334.33328333599;13447.327633618475;13518.526851560147;12092.334921579397;12477.5008999639;13139.60581182566;13194;14038;11296.209265351676;11705.414729263332;11715.589954351557;11719.589814356457;11751;9510;9512.714618561455;11654.53381864716;12243;12343.012558995079 06:34:18 INFO - PROCESS | 11653 | __end_tp_report 06:34:18 INFO - PROCESS | 11653 | __start_cc_report 06:34:18 INFO - PROCESS | 11653 | _x_x_mozilla_cycle_collect,1531 06:34:18 INFO - PROCESS | 11653 | __end_cc_report 06:34:18 INFO - PROCESS | 11653 | __startTimestamp1476106458476__endTimestamp 06:34:18 INFO - PROCESS | 11653 | 06:34:18 INFO - PROCESS | 11653 | ------- Summary: start ------- 06:34:18 INFO - PROCESS | 11653 | Number of tests: 6 06:34:18 INFO - PROCESS | 11653 | 06:34:18 INFO - PROCESS | 11653 | [#0] dojo.html Cycles:165 Average:5142.17 Median:5343.20 stddev:566.55 (10.6%) stddev-sans-first:542.31 06:34:18 INFO - PROCESS | 11653 | Values: 2980.4 3016.6 3018.7 3041.9 3046.8 5109.3 5141.3 5175.1 5197.8 5220.1 5171.5 5208.0 5208.7 5223.5 5233.0 4696.5 4770.8 4778.3 4801.0 4810.1 4677.5 4737.4 4748.1 4781.9 4789.1 4735.3 4740.7 4761.9 4766.8 4824.2 4621.9 4652.9 4701.1 4734.7 4743.2 4567.1 4576.4 4600.9 4610.6 4667.6 5049.5 5062.5 5065.4 5079.0 5141.6 5367.0 5528.5 5529.8 5535.3 5539.9 5443.2 5510.3 5513.4 5567.1 5622.1 5175.2 5184.1 5185.5 5186.0 5187.7 5665.9 5670.9 5673.0 5680.2 5743.9 5217.2 5236.5 5390.4 5433.8 5446.6 5523.0 5524.1 5525.5 5529.3 5586.1 5452.3 5495.5 5495.9 5508.2 5515.3 5371.7 5412.8 5415.5 5466.3 5572.1 4282.7 4284.0 4285.0 4288.2 4289.2 3858.7 3876.4 3878.5 3880.4 3881.7 5219.3 5224.1 5225.7 5228.7 5228.9 5473.3 5519.0 5527.8 5537.0 5538.7 5251.4 5259.6 5279.7 5283.0 5284.8 4825.6 4826.1 4841.9 4853.4 4855.9 5801.7 5806.3 5806.9 5813.8 5837.1 5376.2 5430.6 5622.6 5634.4 5707.8 5669.7 5683.9 5689.3 5707.1 5783.2 5432.6 5434.9 5435.5 5436.5 5439.5 5359.2 5534.4 5539.3 5539.9 5603.8 5279.3 5334.1 5351.0 5383.4 5428.1 5361.9 5365.0 5370.5 5370.7 5373.9 5351.4 5362.0 5365.9 5385.6 5432.5 5288.1 5321.3 5380.6 5448.1 5500.4 5341.1 5343.2 5386.8 5401.2 5403.1 06:34:18 INFO - PROCESS | 11653 | 06:34:18 INFO - PROCESS | 11653 | [#1] ext.html Cycles:180 Average:57427.31 Median:39394.90 stddev:108157.96 (274.5%) stddev-sans-first:108377.04 06:34:18 INFO - PROCESS | 11653 | Values: 540.8 589.4 593.6 599.4 612.3 31683.2 32412.0 42774.8 43837.5 43974.0 40617.8 44715.6 44757.3 44792.0 44793.1 8898.4 9051.9 9059.6 9063.0 9064.4 8123.4 8353.7 8827.1 10569.4 10867.1 10986.3 11081.5 11087.6 11089.0 11090.8 10844.0 10895.4 10897.6 10905.8 10910.9 10642.5 10665.9 10694.6 10695.3 10723.5 42623.8 42657.6 43000.4 43120.1 43128.4 3488.3 3608.2 3999.2 4155.9 4217.5 32079.4 32186.7 32194.0 32296.7 32434.2 4134.5 4193.7 4241.4 4289.4 4311.8 338683.0 338782.0 341163.0 341363.0 341549.0 58189.7 58305.4 58453.4 58724.2 58736.4 62035.7 62040.7 62199.0 62201.7 62206.0 16501.2 16662.8 16663.3 16673.3 16678.8 12358.8 13427.8 13459.3 13481.4 13484.1 14891.2 16668.5 17192.1 17440.0 17659.7 6275.9 6340.2 6367.7 6398.3 6621.1 963.4 1035.7 1058.4 1068.9 1076.2 31406.5 32285.8 32399.2 32712.0 32818.5 1043.0 1098.5 1111.3 1121.0 1211.2 16529.9 17097.0 17294.8 17479.6 17805.9 470125.0 472739.0 473176.0 474473.0 474576.0 58441.0 58514.4 58635.7 58697.1 58729.7 1118.8 1176.3 1274.3 1309.2 1345.7 30149.9 33515.8 33539.8 33582.3 33898.8 49712.5 50293.7 50426.7 50468.2 50474.7 402720.0 404400.0 406399.0 406452.0 407395.0 27059.7 27587.9 28097.6 28364.4 28913.9 47988.0 48319.5 48415.5 48825.3 49055.0 39128.8 40670.6 40933.8 41213.8 42402.0 39930.0 40730.6 41396.4 41438.4 41793.0 39661.0 39685.4 40197.4 40611.6 40642.8 33680.3 35736.0 36366.6 36530.6 36566.8 27686.4 27771.2 28111.9 28176.4 28229.6 06:34:18 INFO - PROCESS | 11653 | 06:34:18 INFO - PROCESS | 11653 | [#2] jquery.html Cycles:180 Average:28058.69 Median:22685.10 stddev:74359.38 (327.8%) stddev-sans-first:74538.93 06:34:18 INFO - PROCESS | 11653 | Values: 378.3 396.2 405.5 410.4 417.4 13022.9 14973.3 18288.3 18661.9 19272.2 18413.5 18699.6 19065.8 19082.0 19362.7 5459.8 5499.0 5721.0 5722.4 5725.7 5574.8 5586.9 5628.9 5631.1 5669.1 5396.8 5592.4 5596.6 5598.8 5600.4 5541.5 5578.1 5580.5 5618.7 5622.1 4833.0 5014.3 5076.2 5078.7 5079.3 22502.2 22542.0 22549.8 22638.8 22731.4 2392.0 2438.4 2439.3 2456.5 3042.6 14053.4 14098.4 14207.2 14334.2 14435.4 1883.6 1933.4 1974.6 1999.5 2041.9 83295.2 83845.0 84722.6 84750.6 86898.0 10493.2 10522.9 10562.4 10781.3 10815.5 14793.6 14894.4 15086.6 15118.2 15130.2 7945.8 7967.8 8365.8 8621.7 8626.7 8119.4 8322.6 8323.0 8434.4 8570.9 6239.5 6432.4 6486.0 6541.7 6556.7 1803.3 1922.1 1936.2 1943.3 1990.0 833.9 968.9 979.7 1024.5 1028.0 18187.7 19806.8 19881.3 19891.8 20336.6 1024.0 1036.4 1039.9 1068.7 1103.3 10014.7 11264.4 11355.9 11421.8 11423.9 418481.0 422544.0 461856.0 465326.0 470340.0 94842.0 96708.5 97373.5 99168.5 99550.5 1009.5 1041.5 1067.2 1070.3 1071.8 17037.5 17320.9 17439.7 17495.5 17977.2 40890.6 41147.6 41802.0 43010.0 44035.6 53184.0 56683.7 57254.1 57687.4 57877.4 8107.2 8321.6 8473.2 8728.7 8891.2 12416.5 12471.5 12716.2 12723.7 13354.5 11032.6 11623.1 11687.4 11714.0 12023.2 11064.0 11082.6 11090.2 11149.6 11233.8 10877.8 11249.8 11628.1 11677.1 11932.5 7057.7 7627.9 8262.8 8446.9 8712.7 10392.4 11146.2 11166.3 11311.9 11753.4 06:34:18 INFO - PROCESS | 11653 | 06:34:18 INFO - PROCESS | 11653 | [#3] mootools.html Cycles:180 Average:5725.84 Median:4888.97 stddev:3260.70 (66.7%) stddev-sans-first:3253.17 06:34:18 INFO - PROCESS | 11653 | Values: 1338.3 1434.2 1465.3 1619.3 1758.0 7827.3 8630.9 8924.7 8937.8 9179.3 8896.2 8981.4 8985.5 8986.8 8992.1 2294.4 2361.8 2366.1 2377.6 2391.5 2329.4 2358.4 2360.8 2372.3 2386.8 2325.2 2325.7 2348.3 2380.5 2384.7 2303.3 2331.0 2338.1 2339.4 2354.5 2251.3 2265.5 2274.6 2287.7 2291.1 8811.2 8893.2 8900.8 8903.9 8904.0 5226.1 5403.3 5406.0 5481.4 5482.4 3433.2 3446.4 3468.3 3501.4 3520.1 1069.6 1077.6 1098.4 1106.1 1115.1 11945.1 11970.8 12062.7 12089.6 12089.8 4340.7 4455.1 4636.5 4637.2 4641.9 9517.4 9527.2 9544.9 9552.2 9567.1 5280.8 5290.4 5295.4 5295.6 5298.7 4306.9 4317.5 4331.9 4472.7 4949.5 3600.3 3912.9 3919.1 3931.4 3937.9 1079.6 1090.6 1106.5 1107.2 1113.9 888.1 914.9 932.2 937.7 957.8 5654.4 5740.3 5867.7 6119.2 6399.9 956.9 990.5 1000.9 1035.6 1045.8 3810.8 3933.5 3969.0 3974.7 4017.2 10665.5 11061.9 11077.8 11084.8 11131.5 10927.0 11022.4 11035.5 11119.8 11134.7 7233.5 7538.2 7543.5 7707.3 7865.1 5568.8 5817.9 5839.1 5942.4 6061.3 9777.1 9862.0 9910.2 10048.1 10106.1 8447.2 10195.7 10262.7 10338.2 10482.2 7198.7 7649.5 7826.5 7879.7 8070.5 8399.7 8517.0 8544.2 8579.1 8646.6 7661.0 7692.4 7711.9 7815.6 7932.1 7675.6 7692.5 7702.5 7727.7 7858.5 6573.7 6607.5 6707.7 6791.5 6801.6 4879.0 4890.1 4932.8 4976.1 5071.9 4873.2 4887.9 5010.7 5011.1 5077.3 06:34:18 INFO - PROCESS | 11653 | 06:34:18 INFO - PROCESS | 11653 | [#4] prototype.html Cycles:180 Average:4608.73 Median:5272.60 stddev:1341.72 (25.4%) stddev-sans-first:1306.47 06:34:18 INFO - PROCESS | 11653 | Values: 329.0 336.5 341.6 349.1 350.9 5266.8 5270.6 5271.5 5272.2 5309.6 4877.3 5235.4 5238.2 5248.5 5259.2 3972.9 3997.9 4058.0 4069.8 4076.9 4038.9 4052.0 4053.0 4058.9 4065.6 3881.2 4026.7 4034.4 4043.8 4045.2 3953.8 3984.7 3997.6 4036.8 4067.7 3597.5 3602.9 3604.4 3623.9 3627.3 5068.5 5084.1 5115.5 5116.0 5144.7 4560.6 4667.4 4678.8 4685.3 4703.6 5366.6 5377.7 5384.4 5395.6 5411.6 4006.9 4014.9 4037.2 4038.6 4046.5 5346.1 5545.7 5625.9 5637.5 5677.7 4094.5 4125.3 4126.2 4134.2 4152.5 4204.0 4210.5 4211.8 4215.9 4219.7 4455.6 4662.5 4721.4 4747.7 4749.3 5442.4 5443.1 5445.9 5447.8 5465.7 1444.5 1458.0 1461.0 1463.1 1474.9 918.3 945.3 954.3 965.8 976.2 5079.7 5117.8 5253.2 5273.0 5286.6 5560.7 5588.4 5605.7 5618.7 5634.0 5051.3 5333.4 5343.7 5346.5 5381.2 2948.5 2991.3 2997.0 2998.7 3004.4 5817.2 5834.6 5835.4 5857.6 5878.9 5599.6 5731.8 5743.8 5744.6 5759.2 5805.3 5810.7 5816.3 5818.6 5829.7 5258.7 5511.2 5635.4 5676.3 5686.7 5475.2 5483.9 5537.9 5544.9 5564.5 5715.0 5732.8 5759.8 5780.8 5834.7 3649.9 3679.2 3837.8 4043.7 4053.5 5574.8 5583.8 5592.2 5596.4 5596.5 5470.5 5473.5 5485.7 5485.8 5503.2 5204.8 5389.5 5405.2 5438.4 5456.9 5423.0 5432.6 5461.5 5479.4 5489.5 5267.7 5306.7 5366.3 5458.6 5477.6 5342.3 5355.3 5359.5 5362.4 5369.2 06:34:18 INFO - PROCESS | 11653 | 06:34:18 INFO - PROCESS | 11653 | [#5] yui.html Cycles:180 Average:19421.13 Median:4416.29 stddev:27736.67 (628.1%) stddev-sans-first:27778.75 06:34:18 INFO - PROCESS | 11653 | Values: 671.8 688.1 698.3 812.2 831.1 13233.4 14008.5 14026.9 14039.4 14099.3 13235.1 13356.5 13466.5 13789.6 13951.7 803.7 823.3 824.7 825.0 825.9 668.6 692.3 789.4 822.9 825.6 860.8 875.3 875.7 877.4 878.4 866.4 867.3 868.4 868.7 868.8 503.6 519.2 601.9 629.6 636.8 12693.7 13227.0 13227.9 13233.9 13240.8 13208.9 13917.7 14148.7 14177.9 14183.8 12347.9 12609.9 12755.8 12863.7 13101.9 4312.2 4348.0 4402.0 4402.4 4419.0 74174.0 74383.3 74422.6 76376.9 77484.6 10636.5 10836.9 11157.8 11161.8 11209.6 20397.4 20403.0 20429.6 20459.8 20516.3 8067.9 8077.6 8181.3 8220.7 8336.5 4409.2 4450.2 4527.8 4546.7 4590.2 3405.5 3484.9 3496.0 3505.9 3512.4 615.3 623.2 628.3 631.3 632.5 640.4 642.8 670.2 680.9 685.2 7625.8 8469.2 8642.3 8701.5 8725.3 471.3 584.9 591.2 594.7 646.6 4007.5 4292.3 4335.9 4378.8 4413.6 71141.6 71789.3 72075.0 100224.0 117249.0 101004.0 101009.0 104489.0 105413.0 109473.0 71703.0 90921.5 92704.0 93124.5 94195.0 9191.8 9307.6 9828.8 9955.2 10014.7 47271.3 48847.0 50268.0 51270.5 51863.2 47704.3 48604.8 49278.5 70187.3 71354.0 11966.3 12118.4 12657.0 12840.0 13111.2 14082.7 14348.9 14382.6 14483.2 15397.2 12515.4 12988.6 13121.3 13560.6 13953.6 12492.2 12604.4 13334.3 13447.3 13518.5 12092.3 12477.5 13139.6 13194.0 14038.0 11296.2 11705.4 11715.6 11719.6 11751.0 9510.0 9512.7 11654.5 12243.0 12343.0 06:34:18 INFO - PROCESS | 11653 | -------- Summary: end -------- 06:34:18 INFO - PROCESS | 11653 | 06:34:19 INFO - TEST-INFO | 11653: exit 0 06:34:19 INFO - TEST-OK | dromaeo_css | took 1117592ms 06:34:19 INFO - TEST-START | kraken 06:34:19 INFO - operating with platform_type : linux_ 06:34:19 INFO - Initialising browser for kraken test... 06:34:19 INFO - TEST-INFO | started process 11965 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpckbKST/profile http://localhost:36751/getInfo.html) 06:34:23 INFO - PROCESS | 11965 | __metrics Screen width/height:1600/1200 06:34:23 INFO - PROCESS | 11965 | colorDepth:24 06:34:23 INFO - PROCESS | 11965 | Browser inner width/height: 1024/697 06:34:23 INFO - PROCESS | 11965 | __metrics 06:34:24 INFO - PROCESS | 11965 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:34:24 INFO - PROCESS | 11965 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:34:24 INFO - PROCESS | 11965 | console.error: PushService: 06:34:24 INFO - PROCESS | 11965 | stateChangeProcessEnqueue: Error transitioning state 06:34:24 INFO - PROCESS | 11965 | UnknownError 06:34:25 INFO - TEST-INFO | 11965: exit 0 06:34:25 INFO - Browser initialized. 06:34:25 INFO - Running cycle 1/1 for kraken test... 06:34:25 INFO - TEST-INFO | started process 12048 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpckbKST/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:34:37 INFO - PROCESS | 12048 | RSS: Main: 173027328 06:34:37 INFO - PROCESS | 12048 | 06:34:40 INFO - PROCESS | 12048 | Cycle 1(1): loaded http://localhost:36751/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36751/tests/kraken/driver.html?testName=audio-beat-detection) 06:34:40 INFO - PROCESS | 12048 | RSS: Main: 231219200 06:34:40 INFO - PROCESS | 12048 | 06:34:43 INFO - PROCESS | 12048 | Cycle 1(1): loaded http://localhost:36751/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36751/tests/kraken/driver.html?testName=audio-dft) 06:34:44 INFO - PROCESS | 12048 | RSS: Main: 216817664 06:34:44 INFO - PROCESS | 12048 | 06:34:47 INFO - PROCESS | 12048 | Cycle 1(1): loaded http://localhost:36751/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36751/tests/kraken/driver.html?testName=audio-fft) 06:34:47 INFO - PROCESS | 12048 | RSS: Main: 298283008 06:34:47 INFO - PROCESS | 12048 | 06:34:50 INFO - PROCESS | 12048 | Cycle 1(1): loaded http://localhost:36751/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36751/tests/kraken/driver.html?testName=audio-oscillator) 06:34:50 INFO - PROCESS | 12048 | RSS: Main: 210239488 06:34:50 INFO - PROCESS | 12048 | 06:34:52 INFO - PROCESS | 12048 | Cycle 1(1): loaded http://localhost:36751/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36751/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:34:53 INFO - PROCESS | 12048 | RSS: Main: 213024768 06:34:53 INFO - PROCESS | 12048 | 06:34:56 INFO - PROCESS | 12048 | Cycle 1(1): loaded http://localhost:36751/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36751/tests/kraken/driver.html?testName=imaging-darkroom) 06:34:57 INFO - PROCESS | 12048 | RSS: Main: 249192448 06:34:57 INFO - PROCESS | 12048 | 06:35:00 INFO - PROCESS | 12048 | Cycle 1(1): loaded http://localhost:36751/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36751/tests/kraken/driver.html?testName=imaging-desaturate) 06:35:00 INFO - PROCESS | 12048 | RSS: Main: 247750656 06:35:00 INFO - PROCESS | 12048 | 06:35:03 INFO - PROCESS | 12048 | Cycle 1(1): loaded http://localhost:36751/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36751/tests/kraken/driver.html?testName=json-parse-financial) 06:35:04 INFO - PROCESS | 12048 | RSS: Main: 247582720 06:35:04 INFO - PROCESS | 12048 | 06:35:05 INFO - PROCESS | 12048 | Cycle 1(1): loaded http://localhost:36751/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36751/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:35:06 INFO - PROCESS | 12048 | RSS: Main: 209936384 06:35:06 INFO - PROCESS | 12048 | 06:35:08 INFO - PROCESS | 12048 | Cycle 1(1): loaded http://localhost:36751/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36751/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:35:08 INFO - PROCESS | 12048 | RSS: Main: 217382912 06:35:08 INFO - PROCESS | 12048 | 06:35:10 INFO - PROCESS | 12048 | Cycle 1(1): loaded http://localhost:36751/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36751/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:35:11 INFO - PROCESS | 12048 | RSS: Main: 226885632 06:35:11 INFO - PROCESS | 12048 | 06:35:14 INFO - PROCESS | 12048 | Cycle 1(1): loaded http://localhost:36751/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36751/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:35:14 INFO - PROCESS | 12048 | RSS: Main: 235839488 06:35:14 INFO - PROCESS | 12048 | 06:35:17 INFO - PROCESS | 12048 | Cycle 1(1): loaded http://localhost:36751/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36751/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:35:18 INFO - PROCESS | 12048 | RSS: Main: 232079360 06:35:18 INFO - PROCESS | 12048 | 06:35:19 INFO - PROCESS | 12048 | Cycle 1(1): loaded http://localhost:36751/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36751/tests/kraken/driver.html?testName=ai-astar) 06:35:20 INFO - PROCESS | 12048 | RSS: Main: 282116096 06:35:20 INFO - PROCESS | 12048 | 06:35:20 INFO - PROCESS | 12048 | __start_tp_report 06:35:20 INFO - PROCESS | 12048 | _x_x_mozilla_page_load 06:35:20 INFO - PROCESS | 12048 | _x_x_mozilla_page_load_details 06:35:20 INFO - PROCESS | 12048 | |i|pagename|runs| 06:35:20 INFO - PROCESS | 12048 | |0;ai-astar;111;112;114;114;113;112;113;112;113;111 06:35:20 INFO - PROCESS | 12048 | |1;audio-beat-detection;151;122;122;152;127;126;124;121;162;122 06:35:20 INFO - PROCESS | 12048 | |2;audio-dft;162;162;162;160;162;163;162;163;162;162 06:35:20 INFO - PROCESS | 12048 | |3;audio-fft;75;75;76;105;77;76;76;76;106;75 06:35:20 INFO - PROCESS | 12048 | |4;audio-oscillator;82;81;110;83;83;83;114;82;81;105 06:35:20 INFO - PROCESS | 12048 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;116;117;117 06:35:20 INFO - PROCESS | 12048 | |6;imaging-darkroom;147;147;147;147;145;146;147;145;145;146 06:35:20 INFO - PROCESS | 12048 | |7;imaging-desaturate;94;96;95;95;95;95;95;95;98;95 06:35:20 INFO - PROCESS | 12048 | |8;json-parse-financial;54;53;53;53;54;54;55;56;55;55 06:35:20 INFO - PROCESS | 12048 | |9;json-stringify-tinderbox;60;60;60;61;62;61;61;60;60;64 06:35:20 INFO - PROCESS | 12048 | |10;stanford-crypto-aes;88;81;78;80;87;79;80;88;83;80 06:35:20 INFO - PROCESS | 12048 | |11;stanford-crypto-ccm;136;134;141;129;132;139;129;130;163;140 06:35:20 INFO - PROCESS | 12048 | |12;stanford-crypto-pbkdf2;166;163;167;172;163;174;167;163;166;164 06:35:20 INFO - PROCESS | 12048 | |13;stanford-crypto-sha256-iterative;66;65;66;65;65;65;66;64;65;63 06:35:20 INFO - PROCESS | 12048 | __end_tp_report 06:35:20 INFO - PROCESS | 12048 | __start_cc_report 06:35:20 INFO - PROCESS | 12048 | _x_x_mozilla_cycle_collect,1660 06:35:20 INFO - PROCESS | 12048 | __end_cc_report 06:35:20 INFO - PROCESS | 12048 | __startTimestamp1476106520159__endTimestamp 06:35:20 INFO - PROCESS | 12048 | 06:35:20 INFO - PROCESS | 12048 | ------- Summary: start ------- 06:35:20 INFO - PROCESS | 12048 | Number of tests: 14 06:35:20 INFO - PROCESS | 12048 | 06:35:20 INFO - PROCESS | 12048 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.00 stddev:1.08 (1.0%) stddev-sans-first:1.00 06:35:20 INFO - PROCESS | 12048 | Values: 111.0 112.0 114.0 114.0 113.0 112.0 113.0 112.0 113.0 111.0 06:35:20 INFO - PROCESS | 12048 | 06:35:20 INFO - PROCESS | 12048 | [#1] audio-beat-detection Cycles:10 Average:132.90 Median:126.50 stddev:15.63 (12.4%) stddev-sans-first:15.14 06:35:20 INFO - PROCESS | 12048 | Values: 151.0 122.0 122.0 152.0 127.0 126.0 124.0 121.0 162.0 122.0 06:35:20 INFO - PROCESS | 12048 | 06:35:20 INFO - PROCESS | 12048 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 06:35:20 INFO - PROCESS | 12048 | Values: 162.0 162.0 162.0 160.0 162.0 163.0 162.0 163.0 162.0 162.0 06:35:20 INFO - PROCESS | 12048 | 06:35:20 INFO - PROCESS | 12048 | [#3] audio-fft Cycles:10 Average:81.70 Median:76.00 stddev:12.56 (16.5%) stddev-sans-first:13.09 06:35:20 INFO - PROCESS | 12048 | Values: 75.0 75.0 76.0 105.0 77.0 76.0 76.0 76.0 106.0 75.0 06:35:20 INFO - PROCESS | 12048 | 06:35:20 INFO - PROCESS | 12048 | [#4] audio-oscillator Cycles:10 Average:90.40 Median:82.00 stddev:13.48 (16.4%) stddev-sans-first:13.96 06:35:20 INFO - PROCESS | 12048 | Values: 82.0 81.0 110.0 83.0 83.0 83.0 114.0 82.0 81.0 105.0 06:35:20 INFO - PROCESS | 12048 | 06:35:20 INFO - PROCESS | 12048 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:35:20 INFO - PROCESS | 12048 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 06:35:20 INFO - PROCESS | 12048 | 06:35:20 INFO - PROCESS | 12048 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 06:35:20 INFO - PROCESS | 12048 | Values: 147.0 147.0 147.0 147.0 145.0 146.0 147.0 145.0 145.0 146.0 06:35:20 INFO - PROCESS | 12048 | 06:35:20 INFO - PROCESS | 12048 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:1.06 (1.1%) stddev-sans-first:1.01 06:35:20 INFO - PROCESS | 12048 | Values: 94.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 98.0 95.0 06:35:20 INFO - PROCESS | 12048 | 06:35:20 INFO - PROCESS | 12048 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.50 stddev:1.03 (1.9%) stddev-sans-first:1.09 06:35:20 INFO - PROCESS | 12048 | Values: 54.0 53.0 53.0 53.0 54.0 54.0 55.0 56.0 55.0 55.0 06:35:20 INFO - PROCESS | 12048 | 06:35:20 INFO - PROCESS | 12048 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:1.29 (2.1%) stddev-sans-first:1.32 06:35:20 INFO - PROCESS | 12048 | Values: 60.0 60.0 60.0 61.0 62.0 61.0 61.0 60.0 60.0 64.0 06:35:20 INFO - PROCESS | 12048 | 06:35:20 INFO - PROCESS | 12048 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.00 stddev:3.86 (4.7%) stddev-sans-first:3.53 06:35:20 INFO - PROCESS | 12048 | Values: 88.0 81.0 78.0 80.0 87.0 79.0 80.0 88.0 83.0 80.0 06:35:20 INFO - PROCESS | 12048 | 06:35:20 INFO - PROCESS | 12048 | [#11] stanford-crypto-ccm Cycles:10 Average:137.30 Median:137.50 stddev:10.09 (7.3%) stddev-sans-first:10.69 06:35:20 INFO - PROCESS | 12048 | Values: 136.0 134.0 141.0 129.0 132.0 139.0 129.0 130.0 163.0 140.0 06:35:20 INFO - PROCESS | 12048 | 06:35:20 INFO - PROCESS | 12048 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.50 Median:166.50 stddev:3.81 (2.3%) stddev-sans-first:4.03 06:35:20 INFO - PROCESS | 12048 | Values: 166.0 163.0 167.0 172.0 163.0 174.0 167.0 163.0 166.0 164.0 06:35:20 INFO - PROCESS | 12048 | 06:35:20 INFO - PROCESS | 12048 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.00 stddev:0.94 (1.5%) stddev-sans-first:0.93 06:35:20 INFO - PROCESS | 12048 | Values: 66.0 65.0 66.0 65.0 65.0 65.0 66.0 64.0 65.0 63.0 06:35:20 INFO - PROCESS | 12048 | -------- Summary: end -------- 06:35:20 INFO - PROCESS | 12048 | 06:35:21 INFO - TEST-INFO | 12048: exit 0 06:35:21 INFO - TEST-OK | kraken | took 61858ms 06:35:21 INFO - SUITE-END | took 1179s 06:35:21 INFO - Completed test suite (00:19:39) 06:35:21 INFO - javascript benchmark 06:35:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2980.4039192161567, 3016.622922134733, 3018.683038280979, 3041.8631161597727, 3046.801957872738, 5109.310243117178, 5141.331626888504, 5175.120229560975, 5197.792088316468, 5220.086484865153, 5171.534561889429, 5207.9739601302035, 5208.713520756357, 5223.529882310591, 5233.031889100519, 4696.53034696531, 4770.785314660831, 4778.307145463906, 4801.0157917626975, 4810.06203790261, 4677.462091859428, 4737.360456338385, 4748.050389922012, 4781.928271075919, 4789.114013907439, 4735.337052812609, 4740.715557066587, 4761.880952976168, 4766.833160839354, 4824.228123500241, 4621.930671039937, 4652.906941861143, 4701.130290896195, 4734.692245004064, 4743.24108142699, 4567.132244873464, 4576.427946506687, 4600.930986035212, 4610.631149508032, 4667.649926255511, 5049.469805670388, 5062.493750624945, 5065.39215294167, 5079.034983353151, 5141.640085194038, 5366.973165134149, 5528.502434780889, 5529.751161197756, 5535.280413546254, 5539.8892022159735, 5443.2107344434835, 5510.256115424407, 5513.448655134494, 5567.081431563787, 5622.072358060915, 5175.223716442564, 5184.14461613837, 5185.455527169668, 5186.014657215117, 5187.662801917863, 5665.915011274834, 5670.943290567124, 5673.0, 5680.233168522279, 5743.85640358986, 5217.2434996925995, 5236.476352364809, 5390.434004429479, 5433.782648694087, 5446.618736688394, 5523.033469142884, 5524.06090964537, 5525.530329921921, 5529.30883639545, 5586.050371436865, 5452.263944367539, 5495.53287970519, 5495.862603434866, 5508.228847961289, 5515.310586176728, 5371.650842695212, 5412.83761487156, 5415.48552887475, 5466.3440387153005, 5572.136318870582, 4282.678799090081, 4284.0, 4285.014446677282, 4288.18524480354, 4289.206496798102, 3858.6527212551005, 3876.3604005339366, 3878.5345758508597, 3880.3791393376923, 3881.7088718346236, 5219.269302297681, 5224.05966925957, 5225.686458812484, 5228.738563071831, 5228.9477105229225, 5473.261109750133, 5518.972405137949, 5527.778888844482, 5537.003339398947, 5538.695371754511, 5251.36983561975, 5259.605529585297, 5279.683219006872, 5283.049051170749, 5284.762185701576, 4825.6139508839915, 4826.0589185108565, 4841.927371089437, 4853.4418541868135, 4855.878603034952, 5801.680907550125, 5806.274215723035, 5806.9419305806405, 5813.76744930198, 5837.09525023622, 5376.247325374529, 5430.619856609999, 5622.550195984393, 5634.408387119293, 5707.800226992035, 5669.659820410789, 5683.943160568341, 5689.345725241485, 5707.143928410772, 5783.248177736868, 5432.565394768488, 5434.945650543444, 5435.510804027656, 5436.483534064258, 5439.456054394529, 5359.222912677717, 5534.363548192009, 5539.252564607163, 5539.944600553943, 5603.80386686464, 5279.313689220377, 5334.06653835585, 5351.0, 5383.353997520323, 5428.131498960148, 5361.892762144813, 5365.034293827149, 5370.543503802221, 5370.677759334452, 5373.919391209057, 5351.438098999549, 5361.986229918638, 5365.865853353697, 5385.649932754359, 5432.456754324536, 5288.074586947346, 5321.30822993024, 5380.623356365017, 5448.073827449264, 5500.367457742411, 5341.118715412069, 5343.198520221998, 5386.7575959082715, 5401.216823560483, 5403.13549832025], "value": 5105.158960720357, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [540.8344723189748, 589.4076453164569, 593.6378808926556, 599.3616798110013, 612.2775125352084, 31683.207919802015, 32412.0, 42774.786126069324, 43837.465688700904, 43974.0, 40617.79691101548, 44715.552844471546, 44757.328640070424, 44792.0, 44793.104137917304, 8898.421602595827, 9051.909480905206, 9059.637614495412, 9062.954685226598, 9064.410813297147, 8123.350131989456, 8353.707620233294, 8827.117288271154, 10569.41868197249, 10867.076298514596, 10986.285891417072, 11081.451266208776, 11087.55649774012, 11089.0, 11090.778184436307, 10844.0, 10895.400752958583, 10897.618583349624, 10905.83641245382, 10910.890891091067, 10642.467876606139, 10665.893341066567, 10694.572217111307, 10695.251332406735, 10723.517441715141, 42623.78688106571, 42657.57342426567, 43000.35499467511, 43120.13759724819, 43128.353074703904, 3488.284901595167, 3608.2061946371755, 3999.2201520703475, 4155.91688166235, 4217.451731274915, 32079.358412831847, 32186.678133218837, 32194.0, 32296.677033229604, 32434.18914527132, 4134.524529679095, 4193.685473589493, 4241.36379543068, 4289.440345778362, 4311.762853043081, 338683.0, 338782.0, 341162.9999999975, 341363.0, 341549.0, 58189.70905145447, 58305.416945830846, 58453.41546584565, 58724.238272851886, 58736.41263587395, 62035.6898215506, 62040.68979655073, 62199.0, 62201.68899155475, 62206.0, 16501.174941252888, 16662.750058749127, 16663.3334666612, 16673.33306667744, 16678.83321166797, 12358.814617780741, 13427.798583021262, 13459.327033648278, 13481.393337299845, 13484.056116071977, 14891.18098504571, 16668.49994500167, 17192.140392980553, 17440.0, 17659.73510397345, 6275.874482510324, 6340.239171299381, 6367.681615919186, 6398.328175541595, 6621.086721842374, 963.3930623707159, 1035.6634093919506, 1058.3861360410942, 1068.9251752377259, 1076.1605947360915, 31406.528902066486, 32285.838570806995, 32399.190020249684, 32712.0, 32818.50772238418, 1042.9739256518649, 1098.4562641492353, 1111.3220935229504, 1120.991108002804, 1211.1642966353188, 16529.917350413172, 17097.0, 17294.827051729575, 17479.563010924827, 17805.883970305145, 470125.0, 472739.0, 473176.0, 474473.0, 474576.0, 58441.0, 58514.41485585175, 58635.70682146562, 58697.119543206885, 58729.70635146883, 1118.7706520163347, 1176.3358284402386, 1274.26729630461, 1309.1817613991254, 1345.724126554054, 30149.851047161053, 33515.83242083774, 33539.83230083834, 33582.328353432305, 33898.8305058483, 49712.502874970785, 50293.74853125711, 50426.7478662619, 50468.242976356116, 50474.74762626163, 402720.0, 404400.0, 406399.0, 406452.0, 407395.0, 27059.72940270572, 27587.862060689567, 28097.57853632238, 28364.43271134607, 28913.855430722713, 47988.04023919572, 48319.51680483291, 48415.5158448411, 48825.267620985, 49055.0, 39128.804355978034, 40670.59329406786, 40933.79533102315, 41213.79393103015, 42402.0, 39930.0, 40730.59269407268, 41396.37905431481, 41438.378424323055, 41793.0, 39661.0, 39685.404718928665, 40197.397039043855, 40611.593884061964, 40642.79678601588, 33680.32639347248, 35736.0, 36366.63633363633, 36530.634693652726, 36566.817165914, 27686.44627107487, 27771.166864994084, 28111.859440702665, 28176.436471270048, 28229.576556352084], "value": 20212.999948613986, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.27182673353786, 396.17397725741824, 405.525535123905, 410.41925675169637, 417.3781066211346, 13022.934885325572, 14973.326200320984, 18288.26846926123, 18661.906690466563, 19272.229110835586, 18413.53966150847, 18699.626007479877, 19065.809341906577, 19082.0, 19362.709559356586, 5459.781608735656, 5498.972505137489, 5720.9713951430185, 5722.399148089453, 5725.685087320217, 5574.777008919658, 5586.944130558703, 5628.915566266509, 5631.0708733059, 5669.09294512878, 5396.757145928423, 5592.384837667873, 5596.552275817925, 5598.776048958037, 5600.355959064698, 5541.501264886159, 5578.0517312056845, 5580.525655319303, 5618.6628802272, 5622.128570071645, 4833.0, 5014.34813474246, 5076.162433198518, 5078.669886457368, 5079.314292570492, 22502.21242256513, 22542.0, 22549.77450225493, 22638.77361226383, 22731.431714207112, 2391.9521609567887, 2438.3538362333998, 2439.316991242455, 2456.459578892641, 3042.6196725409322, 14053.367598457991, 14098.436062557485, 14207.153070100923, 14334.21161836109, 14435.350409231505, 1883.6138591588829, 1933.4103098554936, 1974.575466274758, 1999.4701404127918, 2041.8774873507637, 83295.16704832995, 83845.0, 84722.57638711829, 84750.57624711898, 86898.0, 10493.213009024354, 10522.894771052344, 10562.419066951237, 10781.299215550964, 10815.459227038617, 14793.63015924589, 14894.404223830925, 15086.622834429227, 15118.168500732565, 15130.167840768643, 7945.761627151194, 7967.8406431871035, 8365.832683346422, 8621.741347759576, 8626.698065567674, 8119.431639785158, 8322.62548185321, 8323.0, 8434.409591328671, 8570.914290857012, 6239.532035097386, 6432.42108210254, 6486.0, 6541.705623246965, 6556.672166391661, 1803.2606631281112, 1922.1158267196965, 1936.244864502845, 1943.2906988948932, 1989.9602007959759, 833.9166083391613, 968.8934217236099, 979.7060881735451, 1024.538957469142, 1027.9640212592524, 18187.727184092248, 19806.801931980783, 19881.30415435453, 19891.801081989284, 20336.593268134555, 1023.99488002561, 1036.404067661098, 1039.896010398954, 1068.6793961811425, 1103.3049179017169, 10014.693681716786, 11264.380459074666, 11355.943220283845, 11421.771564568662, 11423.942880285545, 418481.0, 422544.0, 461856.0, 465326.0, 470340.0, 94842.0, 96708.51645741866, 97373.51313243389, 99168.50415747875, 99550.5022474883, 1009.5204777730519, 1041.5469270867197, 1067.2422579968309, 1070.29895418501, 1071.796358691846, 17037.48887533376, 17320.91339543294, 17439.738403923697, 17495.49252583335, 17977.191026403583, 40890.591094088675, 41147.58852411438, 41802.0, 43010.0, 44035.55964440443, 53184.0, 56683.716581416826, 57254.14118788138, 57687.423125769885, 57877.369810415905, 8107.1892810718455, 8321.646092166511, 8473.152684731724, 8728.69449569262, 8891.155340242667, 12416.503339866304, 12471.5011399543, 12716.173448726173, 12723.745525089262, 13354.532591359644, 11032.558697652004, 11623.07015438746, 11687.415629218334, 11714.0, 12023.158378913393, 11064.0, 11082.556697732323, 11090.223684342018, 11149.609763658233, 11233.831492527783, 10877.782444351227, 11249.831252531056, 11628.127890408423, 11677.124215684027, 11932.522699091938, 7057.7176912922905, 7627.8855817161675, 8262.752117436487, 8446.873296900429, 8712.69505567302, 10392.428416436866, 11146.219764616399, 11166.330020198815, 11311.886881131084, 11753.412329383667], "value": 9296.733177314387, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1338.2840180503433, 1434.153849228955, 1465.2746890289307, 1619.2794206578071, 1757.9824201757986, 7827.2955434011, 8630.91369086309, 8924.732258032253, 8937.776555586106, 9179.31155163362, 8896.243819275369, 8981.416207946495, 8985.505797181153, 8986.820263594724, 8992.145746154105, 2294.3919861236745, 2361.8346715729904, 2366.065404165354, 2377.643353496972, 2391.533650938059, 2329.406001469623, 2358.41039740065, 2360.7875291223786, 2372.264597974625, 2386.8090552755825, 2325.2442956039354, 2325.744168141503, 2348.295511346598, 2380.5357955198742, 2384.701912260967, 2303.285981345788, 2330.976690233101, 2338.1465764995824, 2339.415146213447, 2354.5173239485866, 2251.313349428424, 2265.524239909621, 2274.590573696734, 2287.6911616931666, 2291.0721157931066, 8811.162939520735, 8893.155150260714, 8900.777480562972, 8903.866442003375, 8903.955480222623, 5226.111561034633, 5403.297571315704, 5405.972970135124, 5481.369642491125, 5482.369527504348, 3433.1588760753525, 3446.3968805459194, 3468.271662950783, 3501.404761190578, 3520.137566296248, 1069.6363236499549, 1077.5635867473686, 1098.4435411916281, 1106.1206340958877, 1115.0800589513683, 11945.104117191246, 11970.760584788255, 12062.698432539257, 12089.6373108806, 12089.758204835942, 4340.674449416243, 4455.086707225011, 4636.513166117509, 4637.165310244189, 4641.907161856811, 9517.381370210915, 9527.237820974306, 9544.904550954541, 9552.235821134293, 9567.091126342986, 5280.762365693553, 5290.365156181206, 5295.443978382292, 5295.629305948547, 5298.655587386807, 4306.935395969063, 4317.546657600969, 4331.935020974688, 4472.731636101845, 4949.505049495022, 3600.261946301002, 3912.882613521599, 3919.0986073202753, 3931.4495970564144, 3937.940930886039, 1079.5573814735922, 1090.5637744901944, 1106.502074066657, 1107.2028139739375, 1113.8774734779167, 888.1030159538913, 914.9130832570895, 932.2402242172608, 937.6952490440498, 957.7892863570142, 5654.434556544395, 5740.339860916049, 5867.70661466925, 6119.173911521976, 6399.9360006400275, 956.8756061711933, 990.5245482168599, 1000.9399436033862, 1035.6323505155713, 1045.811753884293, 3810.7713537187856, 3933.5083114610675, 3968.980155099206, 3974.701897357652, 4017.2367250222364, 10665.466726663792, 11061.944690276498, 11077.778444431227, 11084.833727494093, 11131.499082541304, 10927.0, 11022.44887755609, 11035.503402346914, 11119.777604447865, 11134.721631959266, 7233.493655444068, 7538.170801211862, 7543.47195696296, 7707.306342429209, 7865.056193256732, 5568.765360561059, 5817.94182058174, 5839.0949402842625, 5942.405759424023, 6061.272427407773, 9777.071178238057, 9861.950690246504, 9910.15763660097, 10048.145907597644, 10106.090451859369, 8447.155284471504, 10195.694129176136, 10262.743431413975, 10338.172946164439, 10482.161427085663, 7198.71205151788, 7649.541027538366, 7826.530408175528, 7879.724209652634, 8070.515769053875, 8399.664013439395, 8516.957415212884, 8544.18830211129, 8579.14208579137, 8646.56767161652, 7660.961695191489, 7692.38460923136, 7711.922880771121, 7815.648295826815, 7932.127465978622, 7675.577843218676, 7692.499987500794, 7702.499337543042, 7727.690892364468, 7858.489198202098, 6573.704183311858, 6607.537472376887, 6707.698153583003, 6791.456683465212, 6801.591904485746, 4879.0, 4890.095332363524, 4932.8026878925875, 4976.129177394014, 5071.92392114126, 4873.220284754422, 4887.853364399074, 5010.724410157476, 5011.09800235961, 5077.2637967493765], "value": 4576.428900433284, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.998355008225, 336.5322202139027, 341.57473944938556, 349.067988470783, 350.93858574749413, 5266.789328426863, 5270.604704647148, 5271.499207575283, 5272.209168624709, 5309.575233981282, 4877.292792545088, 5235.397929238139, 5238.188080847465, 5248.5276325130735, 5259.158534634459, 3972.920541589181, 3997.9005773412255, 4057.9710144927535, 4069.837206511736, 4076.9388459173138, 4038.9094944365006, 4051.9594804052026, 4053.0, 4058.898527536806, 4065.552789193201, 3881.243157584272, 4026.6711985044867, 4034.354503279476, 4043.818028188724, 4045.1505183911413, 3953.802309884494, 3984.6812255019527, 3997.5802540733093, 4036.777977211252, 4067.715259931806, 3597.4963505109304, 3602.9279414411567, 3604.441311596707, 3623.9275214495824, 3627.292677927805, 5068.543831055223, 5084.084864724348, 5115.5396014358885, 5116.0, 5144.6655967362, 4560.612347950429, 4667.416572928384, 4678.812847486097, 4685.273782563708, 4703.553162449562, 5366.597505187087, 5377.677339359612, 5384.434634363374, 5395.570173903919, 5411.64824286424, 4006.939895901564, 4014.8594799181888, 4037.212743515016, 4038.6365227129404, 4046.534648515429, 5346.144616861284, 5545.694986775726, 5625.915611265835, 5637.463141586261, 5677.716114194273, 4094.549599544048, 4125.29869922114, 4126.174765047002, 4134.193832202752, 4152.5432202457705, 4203.957960420356, 4210.452641156691, 4211.810468528924, 4215.882791060371, 4219.662427005832, 4455.6212721918355, 4662.510436404129, 4721.362616046858, 4747.667663263538, 4749.311349854252, 5442.401335853053, 5443.129099344086, 5445.891082178414, 5447.809326673548, 5465.672059676433, 1444.5016469318068, 1458.0, 1460.992695036518, 1463.1294379843976, 1474.9336279867432, 918.3066784577735, 945.3288165402641, 954.3176628710366, 965.7971825916636, 976.2239019978991, 5079.6952182869145, 5117.820876269313, 5253.159494480865, 5273.0, 5286.60350473716, 5560.749766260528, 5588.357338905997, 5605.7197140142825, 5618.71305286412, 5633.985817587571, 5051.292819005343, 5333.439988801198, 5343.732813359316, 5346.5455436287575, 5381.165919282517, 2948.4545359108633, 2991.2949618717557, 2996.9700302997126, 2998.7151220634005, 3004.369082492701, 5817.185594016841, 5834.591578589458, 5835.416458354131, 5857.648541087463, 5878.911816322673, 5599.636023658449, 5731.828045158652, 5743.798967036134, 5744.597878148573, 5759.164921086419, 5805.332386775491, 5810.680412577349, 5816.27296587935, 5818.592698511148, 5829.650220986754, 5258.710770907637, 5511.22842802, 5635.393912734851, 5676.318841739017, 5686.658800471985, 5475.206095116266, 5483.890322193613, 5537.9169312459535, 5544.891021795576, 5564.527015203753, 5715.028445164249, 5732.828015159552, 5759.827205183851, 5780.768769249351, 5834.708264586839, 3649.8685407523753, 3679.2457546202427, 3837.788921609338, 4043.73715708478, 4053.452783874139, 5574.804881829116, 5583.832485025293, 5592.161175823497, 5596.4123767003875, 5596.468335508121, 5470.480304371078, 5473.452654734495, 5485.670859748428, 5485.820548582074, 5503.229547863382, 5204.765785539736, 5389.514943654933, 5405.189221616789, 5438.374586922397, 5456.918146227889, 5422.972885135707, 5432.565394768488, 5461.481159289861, 5479.424660410599, 5489.478499542537, 5267.657602255841, 5306.681599104066, 5366.275552800478, 5458.590605704668, 5477.616566840283, 5342.278792362981, 5355.25026496283, 5359.490848369399, 5362.3833259174135, 5369.167778994262], "value": 4188.279524438081, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [671.7951024937394, 688.1123350877367, 698.2528694297101, 812.2162113560421, 831.0858056138253, 13233.404496797642, 14008.509702160427, 14026.859731402683, 14039.438422463101, 14099.295035248248, 13235.139715918483, 13356.465741370333, 13466.528671496475, 13789.586312410618, 13951.720965580682, 803.6825453945688, 823.2878560045548, 824.6660102658403, 824.9628766705513, 825.8761185822144, 668.6355936014859, 692.2558249881372, 789.3645615279697, 822.9341652667772, 825.6119623776815, 860.7805009722512, 875.264777586827, 875.7460336502406, 877.394597727566, 878.4377998081233, 866.4194989357146, 867.3364875869964, 868.3660927522913, 868.7437206024238, 868.7567481105301, 503.6172508893231, 519.1771042897013, 601.9337872833985, 629.625372903122, 636.7994081864198, 12693.682657933534, 13227.0, 13227.86772132276, 13233.867661323457, 13240.801387979189, 13208.86791132086, 13917.652058698613, 14148.717025659533, 14177.85822141786, 14183.78724319136, 12347.876521234852, 12609.93695031519, 12755.808662870064, 12863.678408039874, 13101.868981310256, 4312.202242585132, 4347.978260108711, 4401.977990110061, 4402.44690903666, 4419.005723712171, 74174.0, 74383.25616743817, 74422.62788686076, 76376.85434718429, 77484.61257693732, 10636.521356538975, 10836.891631083747, 11157.776844463227, 11161.776764464665, 11209.607663731731, 20397.38807835767, 20403.0, 20429.591408171753, 20459.795402046086, 20516.281930132373, 8067.878981815277, 8077.5961201940845, 8181.345492360597, 8220.712275070344, 8336.541490217975, 4409.162259170747, 4450.1767173073085, 4527.7736113194205, 4546.74992875395, 4590.196715574761, 3405.506201600754, 3484.8954531364097, 3495.9825200874343, 3505.9123521912156, 3512.438009918401, 615.2678312807744, 623.1649589550025, 628.2649300318639, 631.2897989761518, 632.4529282170981, 640.3948268885952, 642.8135840606266, 670.1689904518362, 680.9455243580601, 685.2325395557008, 7625.847483050419, 8469.195426434479, 8642.265407440313, 8701.521416322037, 8725.301975841918, 471.3424772442424, 584.9208210850973, 591.2284468768298, 594.7323704333068, 646.6023395611664, 4007.519097708235, 4292.325433950175, 4335.9349609755245, 4378.824847006148, 4413.58070983256, 71141.64429177821, 71789.2821071793, 72074.99062617173, 100224.0, 117249.0, 101004.0, 101009.0, 104489.0, 105413.0, 109473.0, 71702.99999999895, 90921.54539227394, 92704.0, 93124.53437732768, 94195.0, 9191.816163676824, 9307.581158847732, 9828.803423931624, 9955.20358371343, 10014.749631258985, 47271.29093063676, 48847.0, 50268.0, 51270.48729512657, 51863.22205167001, 47704.2844357328, 48604.756976216304, 49278.50721492739, 70187.29812702011, 71354.0, 11966.282023078644, 12118.394080295773, 12657.0, 12840.0, 13111.2133272004, 14082.653198586182, 14348.856511434751, 14382.640433989234, 14483.20342381137, 15397.153156576496, 12515.436805343963, 12988.610341689764, 13121.343932803513, 13560.59318220455, 13953.581392558239, 12492.188007779465, 12604.432800524182, 13334.33328333599, 13447.327633618475, 13518.526851560147, 12092.334921579397, 12477.5008999639, 13139.60581182566, 13194.0, 14038.0, 11296.209265351676, 11705.414729263332, 11715.589954351557, 11719.589814356457, 11751.0, 9510.0, 9512.714618561455, 11654.53381864716, 12243.0, 12343.012558995079], "value": 7232.807067378272, "unit": "score"}], "name": "dromaeo_css", "value": 7144.653005762422, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 114.0, 114.0, 113.0, 112.0, 113.0, 112.0, 113.0, 111.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 122.0, 122.0, 152.0, 127.0, 126.0, 124.0, 121.0, 162.0, 122.0], "value": 132.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 160.0, 162.0, 163.0, 162.0, 163.0, 162.0, 162.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 105.0, 77.0, 76.0, 76.0, 76.0, 106.0, 75.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 110.0, 83.0, 83.0, 83.0, 114.0, 82.0, 81.0, 105.0], "value": 90.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 145.0, 146.0, 147.0, 145.0, 145.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 98.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 53.0, 54.0, 54.0, 55.0, 56.0, 55.0, 55.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 61.0, 62.0, 61.0, 61.0, 60.0, 60.0, 64.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 81.0, 78.0, 80.0, 87.0, 79.0, 80.0, 88.0, 83.0, 80.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 134.0, 141.0, 129.0, 132.0, 139.0, 129.0, 130.0, 163.0, 140.0], "value": 137.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 167.0, 172.0, 163.0, 174.0, 167.0, 163.0, 166.0, 164.0], "value": 166.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 65.0, 65.0, 65.0, 66.0, 64.0, 65.0, 63.0], "value": 65.0, "unit": "score"}], "name": "kraken", "value": 1504.1000000000001, "alertThreshold": 2.0}]} 06:35:21 INFO - Return code: 0 06:35:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:35:21 INFO - # TBPL SUCCESS # 06:35:21 INFO - Running post-action listener: _resource_record_post_action 06:35:21 INFO - [mozharness: 2016-10-10 13:35:21.461067Z] Finished run-tests step (success) 06:35:21 INFO - Running post-run listener: _resource_record_post_run 06:35:21 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 404135936; Read time: 0; Write time: 263508 06:35:21 INFO - TinderboxPrint: CPU usage
13.0% 06:35:21 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 06:35:21 INFO - TinderboxPrint: I/O write bytes / time
404,135,936 / 263,508 06:35:21 INFO - TinderboxPrint: CPU idle
8,304.0 (86.9%) 06:35:21 INFO - TinderboxPrint: CPU user
1,197.3 (12.5%) 06:35:21 INFO - TinderboxPrint: Swap in / out
0 / 0 06:35:21 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103944192; Read time: 0; Write time: 82068 06:35:21 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 288882688; Read time: 0; Write time: 176164 06:35:22 INFO - Running post-run listener: _upload_blobber_files 06:35:22 INFO - Blob upload gear active. 06:35:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:35:22 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:35:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:35:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:35:22 INFO - (blobuploader) - INFO - Open directory for files ... 06:35:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:35:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:35:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:35:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:35:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:35:23 INFO - (blobuploader) - INFO - Done attempting. 06:35:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:35:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:35:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:35:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:35:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:35:26 INFO - (blobuploader) - INFO - Done attempting. 06:35:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:35:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:35:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:35:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:35:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:35:27 INFO - (blobuploader) - INFO - Done attempting. 06:35:27 INFO - (blobuploader) - INFO - Iteration through files over. 06:35:27 INFO - Return code: 0 06:35:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:35:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:35:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa66a7c5d9f4dd51b54c6145d4dfdfeaf97dadfda57dfc1ed9c19d2f4cbc1f9b9fbdd4739e537cdaffb0eece17653e19c763e9ee1a7c44b97f361fb7e6081707", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed4ce0cc3c52bb9e44ff159de4fd1a29f8b6bf550aeed1843a2719af9eb4f91b5774ef203f8e3343e52e125a50864ba53757e97833148dbcf2d20ecc4f2c1bc2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3fcc2a04bc82511e03d21205d8b7e31542fd944b394e3be4623542d4e6a8863e4efa856ca67cf74d85dd558363a8407b24c4fba60acef9e196700058ca6756bd"} 06:35:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:35:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:35:27 INFO - Contents: 06:35:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa66a7c5d9f4dd51b54c6145d4dfdfeaf97dadfda57dfc1ed9c19d2f4cbc1f9b9fbdd4739e537cdaffb0eece17653e19c763e9ee1a7c44b97f361fb7e6081707", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed4ce0cc3c52bb9e44ff159de4fd1a29f8b6bf550aeed1843a2719af9eb4f91b5774ef203f8e3343e52e125a50864ba53757e97833148dbcf2d20ecc4f2c1bc2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3fcc2a04bc82511e03d21205d8b7e31542fd944b394e3be4623542d4e6a8863e4efa856ca67cf74d85dd558363a8407b24c4fba60acef9e196700058ca6756bd"} 06:35:27 INFO - Running post-run listener: copy_logs_to_upload_dir 06:35:27 INFO - Copying logs to upload dir... 06:35:27 INFO - mkdir: /builds/slave/test/build/upload/logs 06:35:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.052852 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-10-10 06:35:26.863993) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-10 06:35:26.867138) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1476104369.968406-649384278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa66a7c5d9f4dd51b54c6145d4dfdfeaf97dadfda57dfc1ed9c19d2f4cbc1f9b9fbdd4739e537cdaffb0eece17653e19c763e9ee1a7c44b97f361fb7e6081707", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed4ce0cc3c52bb9e44ff159de4fd1a29f8b6bf550aeed1843a2719af9eb4f91b5774ef203f8e3343e52e125a50864ba53757e97833148dbcf2d20ecc4f2c1bc2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3fcc2a04bc82511e03d21205d8b7e31542fd944b394e3be4623542d4e6a8863e4efa856ca67cf74d85dd558363a8407b24c4fba60acef9e196700058ca6756bd"} build_url:https://queue.taskcluster.net/v1/task/Rhc8FJFoTrCs83uThm9E3A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011307 build_url: 'https://queue.taskcluster.net/v1/task/Rhc8FJFoTrCs83uThm9E3A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa66a7c5d9f4dd51b54c6145d4dfdfeaf97dadfda57dfc1ed9c19d2f4cbc1f9b9fbdd4739e537cdaffb0eece17653e19c763e9ee1a7c44b97f361fb7e6081707", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed4ce0cc3c52bb9e44ff159de4fd1a29f8b6bf550aeed1843a2719af9eb4f91b5774ef203f8e3343e52e125a50864ba53757e97833148dbcf2d20ecc4f2c1bc2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3fcc2a04bc82511e03d21205d8b7e31542fd944b394e3be4623542d4e6a8863e4efa856ca67cf74d85dd558363a8407b24c4fba60acef9e196700058ca6756bd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-10 06:35:26.892648) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 06:35:26.892978) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1476104369.968406-649384278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004484 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 06:35:26.975665) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-10 06:35:26.976011) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-10 06:35:26.976388) ========= ========= Total master_lag: 0.17 =========