builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-015 starttime: 1475769829.37 results: success (0) buildid: 20161006074200 builduid: 710d83a166e84364a42b2184e5a024fe revision: d382e432aa089d0aec8300da50076faddf708701 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 09:03:49.371112) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 09:03:49.371550) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 09:03:49.371837) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 09:03:49.391840) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 09:03:49.392188) ========= 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=20e666a3d4cfbb71505a330e000001b4-1475769828.740062-2084212502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-06 09:03:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 12.2M=0.001s 2016-10-06 09:03:49 (12.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.318994 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 09:03:49.724701) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 09:03:49.725018) ========= 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=20e666a3d4cfbb71505a330e000001b4-1475769828.740062-2084212502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020911 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 09:03:49.777911) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 09:03:49.778883) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev d382e432aa089d0aec8300da50076faddf708701 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev d382e432aa089d0aec8300da50076faddf708701 --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=20e666a3d4cfbb71505a330e000001b4-1475769828.740062-2084212502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-06 09:03:49,907 truncating revision to first 12 chars 2016-10-06 09:03:49,907 Setting DEBUG logging. 2016-10-06 09:03:49,907 attempt 1/10 2016-10-06 09:03:49,907 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/d382e432aa08?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-06 09:03:50,255 unpacking tar archive at: autoland-d382e432aa08/testing/mozharness/ program finished with exit code 0 elapsedTime=0.660391 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 09:03:50.452834) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 09:03:50.453177) ========= script_repo_revision: d382e432aa089d0aec8300da50076faddf708701 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 09:03:50.453595) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 09:03:50.453870) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 09:03:50.463495) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-10-06 09:03:50.463774) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] 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=20e666a3d4cfbb71505a330e000001b4-1475769828.740062-2084212502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:03:50 INFO - MultiFileLogger online at 20161006 09:03:50 in /builds/slave/test 09:03:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 09:03:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:03:50 INFO - {'append_to_log': False, 09:03:50 INFO - 'base_work_dir': '/builds/slave/test', 09:03:50 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 09:03:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:03:50 INFO - 'branch': 'Autoland-Non-PGO', 09:03:50 INFO - 'buildbot_json_path': 'buildprops.json', 09:03:50 INFO - 'config_files': ('talos/linux_config.py',), 09:03:50 INFO - 'default_actions': ('clobber', 09:03:50 INFO - 'read-buildbot-config', 09:03:50 INFO - 'download-and-extract', 09:03:50 INFO - 'populate-webroot', 09:03:50 INFO - 'create-virtualenv', 09:03:50 INFO - 'install', 09:03:50 INFO - 'run-tests'), 09:03:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:03:50 INFO - 'download_minidump_stackwalk': True, 09:03:50 INFO - 'download_symbols': 'ondemand', 09:03:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:03:50 INFO - 'tooltool.py': '/tools/tooltool.py', 09:03:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:03:50 INFO - '/tools/misc-python/virtualenv.py')}, 09:03:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:03:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:03:50 INFO - 'installer_path': 'installer.exe', 09:03:50 INFO - 'log_level': 'info', 09:03:50 INFO - 'log_name': 'talos', 09:03:50 INFO - 'log_to_console': True, 09:03:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:03:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:03:50 INFO - 'opt_config_files': (), 09:03:50 INFO - 'pip_index': False, 09:03:50 INFO - 'sps_profile': False, 09:03:50 INFO - 'sps_profile_interval': 0, 09:03:50 INFO - 'suite': 'dromaeojs-e10s', 09:03:50 INFO - 'system_bits': '32', 09:03:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:03:50 INFO - 'title': 'talos-linux64-ix-015', 09:03:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:03:50 INFO - 'use_talos_json': True, 09:03:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:03:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:03:50 INFO - 'work_dir': 'build'} 09:03:50 INFO - [mozharness: 2016-10-06 16:03:50.685278Z] Running clobber step. 09:03:50 INFO - Running pre-action listener: _resource_record_pre_action 09:03:50 INFO - Running main action method: clobber 09:03:50 INFO - rmtree: /builds/slave/test/build 09:03:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:03:51 INFO - Running post-action listener: _resource_record_post_action 09:03:51 INFO - [mozharness: 2016-10-06 16:03:51.654844Z] Finished clobber step (success) 09:03:51 INFO - [mozharness: 2016-10-06 16:03:51.654944Z] Running read-buildbot-config step. 09:03:51 INFO - Running pre-action listener: _resource_record_pre_action 09:03:51 INFO - Running main action method: read_buildbot_config 09:03:51 INFO - Using buildbot properties: 09:03:51 INFO - { 09:03:51 INFO - "project": "", 09:03:51 INFO - "product": "firefox", 09:03:51 INFO - "script_repo_revision": "production", 09:03:51 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 09:03:51 INFO - "repository": "", 09:03:51 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 09:03:51 INFO - "buildid": "20161006074200", 09:03:51 INFO - "pgo_build": "False", 09:03:51 INFO - "basedir": "/builds/slave/test", 09:03:51 INFO - "buildnumber": 519, 09:03:51 INFO - "slavename": "talos-linux64-ix-015", 09:03:51 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:03:51 INFO - "platform": "ubuntu64_hw", 09:03:51 INFO - "scheduler": "tests-autoland-linux64-talos-8-3600", 09:03:51 INFO - "branch": "autoland", 09:03:51 INFO - "repo_path": "integration/autoland", 09:03:51 INFO - "revision": "d382e432aa089d0aec8300da50076faddf708701", 09:03:51 INFO - "stage_platform": "linux64", 09:03:51 INFO - "builduid": "710d83a166e84364a42b2184e5a024fe", 09:03:51 INFO - "slavebuilddir": "test" 09:03:51 INFO - } 09:03:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/aKZ051ddRCWuDppQ2Nakqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 09:03:51 INFO - Running post-action listener: _resource_record_post_action 09:03:51 INFO - [mozharness: 2016-10-06 16:03:51.657418Z] Finished read-buildbot-config step (success) 09:03:51 INFO - [mozharness: 2016-10-06 16:03:51.657507Z] Running download-and-extract step. 09:03:51 INFO - Running pre-action listener: _resource_record_pre_action 09:03:51 INFO - Running main action method: download_and_extract 09:03:51 INFO - mkdir: /builds/slave/test/build/tests 09:03:51 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')]} 09:03:51 INFO - trying https://queue.taskcluster.net/v1/task/aKZ051ddRCWuDppQ2Nakqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:03:51 INFO - Downloading https://queue.taskcluster.net/v1/task/aKZ051ddRCWuDppQ2Nakqg/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 09:03:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aKZ051ddRCWuDppQ2Nakqg/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 09:03:52 INFO - Downloaded 1361 bytes. 09:03:52 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:03:52 INFO - Using the following test package requirements: 09:03:52 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:03:52 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:03:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:03:52 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:03:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:03:52 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:03:52 INFO - u'jsshell-linux-x86_64.zip'], 09:03:52 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:03:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:03:52 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:03:52 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:03:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:03:52 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:03:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:03:52 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:03:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:03:52 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:03:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:03:52 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:03:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aKZ051ddRCWuDppQ2Nakqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:03:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aKZ051ddRCWuDppQ2Nakqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:03:52 INFO - Fetch https://queue.taskcluster.net/v1/task/aKZ051ddRCWuDppQ2Nakqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:03:52 INFO - Http code: 200 09:03:52 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 09:03:52 INFO - x-amz-cf-id: 3moae1XSxlDYxVjceX8z2iebi702Yvho_m6bB7YcQjusRB8cB4mMQA== 09:03:52 INFO - x-amz-version-id: WBSLEJESUzRggm0HoDzwOt_.3shGavMQ 09:03:53 INFO - Expected file size: 20446373 09:03:53 INFO - Obtained file size: 20446373 09:03:57 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 09:03:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aKZ051ddRCWuDppQ2Nakqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:03:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aKZ051ddRCWuDppQ2Nakqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:03:57 INFO - Fetch https://queue.taskcluster.net/v1/task/aKZ051ddRCWuDppQ2Nakqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:03:57 INFO - Http code: 200 09:03:57 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 09:03:57 INFO - x-amz-cf-id: qKleOvAcqp92Ut_ZUc3LZ1AE4x73o277FDis3a7Z_zx1udx8utLr1Q== 09:03:57 INFO - x-amz-version-id: WBSLEJESUzRggm0HoDzwOt_.3shGavMQ 09:03:57 INFO - Expected file size: 20446373 09:03:57 INFO - Obtained file size: 20446373 09:04:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aKZ051ddRCWuDppQ2Nakqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 09:04:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aKZ051ddRCWuDppQ2Nakqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:04:02 INFO - Fetch https://queue.taskcluster.net/v1/task/aKZ051ddRCWuDppQ2Nakqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 09:04:02 INFO - Http code: 200 09:04:02 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 09:04:02 INFO - x-amz-cf-id: fY-Uu_oOkXY8hbtFQSqFjr2Dgu_7sOSbLWtalpDTz2SNhySqP0TdOg== 09:04:02 INFO - x-amz-version-id: 9TPxsLsrCPAZx3mncZwcMH_a9J4hkGUS 09:04:03 INFO - Expected file size: 14409006 09:04:03 INFO - Obtained file size: 14409006 09:04:03 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')]} 09:04:03 INFO - trying https://queue.taskcluster.net/v1/task/aKZ051ddRCWuDppQ2Nakqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:04:03 INFO - Downloading https://queue.taskcluster.net/v1/task/aKZ051ddRCWuDppQ2Nakqg/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 09:04:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aKZ051ddRCWuDppQ2Nakqg/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 09:04:04 INFO - Downloaded 55809694 bytes. 09:04:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aKZ051ddRCWuDppQ2Nakqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:04:04 INFO - mkdir: /builds/slave/test/properties 09:04:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:04:04 INFO - Writing to file /builds/slave/test/properties/build_url 09:04:04 INFO - Contents: 09:04:04 INFO - build_url:https://queue.taskcluster.net/v1/task/aKZ051ddRCWuDppQ2Nakqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:04:05 INFO - Running post-action listener: _resource_record_post_action 09:04:05 INFO - Running post-action listener: set_extra_try_arguments 09:04:05 INFO - [mozharness: 2016-10-06 16:04:05.091938Z] Finished download-and-extract step (success) 09:04:05 INFO - [mozharness: 2016-10-06 16:04:05.092164Z] Running populate-webroot step. 09:04:05 INFO - Running pre-action listener: _resource_record_pre_action 09:04:05 INFO - Running main action method: populate_webroot 09:04:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:04:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:04:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:04:05 INFO - '--tppagecycles', 09:04:05 INFO - '7'], 09:04:05 INFO - 'tests': ['tsvgm']}}, 09:04:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:04:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:04:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:04:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:04:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:04:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:04:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:05 INFO - 'talos_options': ['--disable-e10s'], 09:04:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:04:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:04:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:05 INFO - 'talos_options': ['--disable-e10s'], 09:04:05 INFO - 'tests': ['damp', 'tps']}, 09:04:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:05 INFO - 'tests': ['damp', 'tps']}, 09:04:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:04:05 INFO - 'tests': ['dromaeo_dom']}, 09:04:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:04:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:04:05 INFO - 'tests': ['basic_compositor_video']}, 09:04:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:04:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:04:05 INFO - 'tests': ['a11yr', 09:04:05 INFO - 'ts_paint', 09:04:05 INFO - 'tpaint', 09:04:05 INFO - 'sessionrestore', 09:04:05 INFO - 'sessionrestore_no_auto_restore', 09:04:05 INFO - 'tabpaint']}, 09:04:05 INFO - 'other-e10s': {'tests': ['a11yr', 09:04:05 INFO - 'ts_paint', 09:04:05 INFO - 'tpaint', 09:04:05 INFO - 'sessionrestore', 09:04:05 INFO - 'sessionrestore_no_auto_restore', 09:04:05 INFO - 'tabpaint']}, 09:04:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:04:05 INFO - 'ts_paint', 09:04:05 INFO - 'tpaint', 09:04:05 INFO - 'sessionrestore', 09:04:05 INFO - 'sessionrestore_no_auto_restore', 09:04:05 INFO - 'tabpaint']}, 09:04:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:04:05 INFO - 'ts_paint', 09:04:05 INFO - 'tpaint', 09:04:05 INFO - 'sessionrestore', 09:04:05 INFO - 'sessionrestore_no_auto_restore', 09:04:05 INFO - 'tabpaint']}, 09:04:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:04:05 INFO - 'tests': ['a11yr', 09:04:05 INFO - 'ts_paint', 09:04:05 INFO - 'tpaint', 09:04:05 INFO - 'sessionrestore', 09:04:05 INFO - 'sessionrestore_no_auto_restore', 09:04:05 INFO - 'tabpaint']}, 09:04:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:04:05 INFO - 'tests': ['a11yr', 09:04:05 INFO - 'ts_paint', 09:04:05 INFO - 'tpaint', 09:04:05 INFO - 'sessionrestore', 09:04:05 INFO - 'sessionrestore_no_auto_restore', 09:04:05 INFO - 'tabpaint']}, 09:04:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:04:05 INFO - 'tests': ['tsvgx', 09:04:05 INFO - 'tsvgr_opacity', 09:04:05 INFO - 'tart', 09:04:05 INFO - 'tscrollx', 09:04:05 INFO - 'cart']}, 09:04:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:04:05 INFO - 'tsvgr_opacity', 09:04:05 INFO - 'tart', 09:04:05 INFO - 'tscrollx', 09:04:05 INFO - 'cart']}, 09:04:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:05 INFO - 'talos_options': ['--disable-e10s'], 09:04:05 INFO - 'tests': ['tp5o']}, 09:04:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:05 INFO - 'tests': ['tp5o']}, 09:04:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:05 INFO - 'talos_options': ['--disable-e10s', 09:04:05 INFO - '--xperf_path', 09:04:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:04:05 INFO - 'tests': ['tp5n']}, 09:04:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:05 INFO - 'talos_options': ['--xperf_path', 09:04:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:04:05 INFO - 'tests': ['tp5n']}}, 09:04:05 INFO - 'talos.zip': {'path': '', 09:04:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:04:05 INFO - Running post-action listener: _resource_record_post_action 09:04:05 INFO - [mozharness: 2016-10-06 16:04:05.113605Z] Finished populate-webroot step (success) 09:04:05 INFO - [mozharness: 2016-10-06 16:04:05.113693Z] Running create-virtualenv step. 09:04:05 INFO - Running pre-action listener: _resource_record_pre_action 09:04:05 INFO - Running main action method: create_virtualenv 09:04:05 INFO - Creating virtualenv /builds/slave/test/build/venv 09:04:05 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 09:04:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:04:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:04:05 INFO - Using real prefix '/usr' 09:04:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:04:05 INFO - Installing distribute.............................................................................................................................................................................................done. 09:04:07 INFO - Installing pip.................done. 09:04:07 INFO - Return code: 0 09:04:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:04:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:04:07 INFO - Reading from file tmpfile_stdout 09:04:07 INFO - Output received: 09:04:07 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) 09:04:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:04: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')]} 09:04:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04: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')]} 09:04:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:07 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 0x7f35e0100f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc1f60>, '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 0x2cc2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc31d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1475769828.740062-2084212502', '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 09:04:07 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 09:04:07 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 09:04:07 INFO - Using env: {'DISPLAY': ':0', 09:04:07 INFO - 'HOME': '/home/cltbld', 09:04:07 INFO - 'LANG': 'en_US.UTF-8', 09:04:07 INFO - 'LANGUAGE': 'en_US:en', 09:04:07 INFO - 'LOGNAME': 'cltbld', 09:04:07 INFO - 'MAIL': '/var/mail/cltbld', 09:04:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:07 INFO - 'MOZ_NO_REMOTE': '1', 09:04:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:07 INFO - 'NO_EM_RESTART': '1', 09:04:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:07 INFO - 'PWD': '/builds/slave/test', 09:04:07 INFO - 'SHELL': '/bin/bash', 09:04:07 INFO - 'SHLVL': '1', 09:04:07 INFO - 'TERM': 'linux', 09:04:07 INFO - 'TMOUT': '86400', 09:04:07 INFO - 'USER': 'cltbld', 09:04:07 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475769828.740062-2084212502', 09:04:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:07 INFO - '_': '/tools/buildbot/bin/python'} 09:04:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:08 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 09:04:08 INFO - Cleaning up... 09:04:08 INFO - Return code: 0 09:04:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:04:08 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')]} 09:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:08 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')]} 09:04:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04: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', '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 0x7f35e0100f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc1f60>, '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 0x2cc2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc31d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1475769828.740062-2084212502', '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 09:04: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', 'psutil>=3.1.1'] in /builds/slave/test/build 09:04: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 psutil>=3.1.1 09:04:08 INFO - Using env: {'DISPLAY': ':0', 09:04:08 INFO - 'HOME': '/home/cltbld', 09:04:08 INFO - 'LANG': 'en_US.UTF-8', 09:04:08 INFO - 'LANGUAGE': 'en_US:en', 09:04:08 INFO - 'LOGNAME': 'cltbld', 09:04:08 INFO - 'MAIL': '/var/mail/cltbld', 09:04:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:08 INFO - 'MOZ_NO_REMOTE': '1', 09:04:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:08 INFO - 'NO_EM_RESTART': '1', 09:04:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:08 INFO - 'PWD': '/builds/slave/test', 09:04:08 INFO - 'SHELL': '/bin/bash', 09:04:08 INFO - 'SHLVL': '1', 09:04:08 INFO - 'TERM': 'linux', 09:04:08 INFO - 'TMOUT': '86400', 09:04:08 INFO - 'USER': 'cltbld', 09:04:08 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475769828.740062-2084212502', 09:04:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:08 INFO - '_': '/tools/buildbot/bin/python'} 09:04:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:08 INFO - Downloading/unpacking psutil>=3.1.1 09:04: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 09:04: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 09:04: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 09:04: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 09:04: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 09:04: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 09:04:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:04:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:04:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:04:10 INFO - Installing collected packages: psutil 09:04:10 INFO - Running setup.py install for psutil 09:04:10 INFO - building 'psutil._psutil_linux' extension 09:04:10 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 09:04:10 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 09:04:10 INFO - building 'psutil._psutil_posix' extension 09:04:10 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 09:04:10 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 09:04:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:04:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:04:10 INFO - Successfully installed psutil 09:04:10 INFO - Cleaning up... 09:04:10 INFO - Return code: 0 09:04:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:04: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')]} 09:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04: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')]} 09:04:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f35e0100f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc1f60>, '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 0x2cc2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc31d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1475769828.740062-2084212502', '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 09:04: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:04: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 mozsystemmonitor==0.3 09:04:10 INFO - Using env: {'DISPLAY': ':0', 09:04:10 INFO - 'HOME': '/home/cltbld', 09:04:10 INFO - 'LANG': 'en_US.UTF-8', 09:04:10 INFO - 'LANGUAGE': 'en_US:en', 09:04:10 INFO - 'LOGNAME': 'cltbld', 09:04:10 INFO - 'MAIL': '/var/mail/cltbld', 09:04:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:10 INFO - 'MOZ_NO_REMOTE': '1', 09:04:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:10 INFO - 'NO_EM_RESTART': '1', 09:04:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:10 INFO - 'PWD': '/builds/slave/test', 09:04:10 INFO - 'SHELL': '/bin/bash', 09:04:10 INFO - 'SHLVL': '1', 09:04:10 INFO - 'TERM': 'linux', 09:04:10 INFO - 'TMOUT': '86400', 09:04:10 INFO - 'USER': 'cltbld', 09:04:10 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475769828.740062-2084212502', 09:04:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:10 INFO - '_': '/tools/buildbot/bin/python'} 09:04:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:04:11 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 09:04:11 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 09:04:11 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 09:04:11 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 09:04:11 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 09:04:11 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 09:04:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:04:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:04:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:04:13 INFO - Installing collected packages: mozsystemmonitor 09:04:13 INFO - Running setup.py install for mozsystemmonitor 09:04:13 INFO - Successfully installed mozsystemmonitor 09:04:13 INFO - Cleaning up... 09:04:13 INFO - Return code: 0 09:04:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:04: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')]} 09:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04: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')]} 09:04:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04: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', '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 0x7f35e0100f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc1f60>, '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 0x2cc2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc31d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1475769828.740062-2084212502', '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 09:04: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:04: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 jsonschema==2.5.1 09:04:13 INFO - Using env: {'DISPLAY': ':0', 09:04:13 INFO - 'HOME': '/home/cltbld', 09:04:13 INFO - 'LANG': 'en_US.UTF-8', 09:04:13 INFO - 'LANGUAGE': 'en_US:en', 09:04:13 INFO - 'LOGNAME': 'cltbld', 09:04:13 INFO - 'MAIL': '/var/mail/cltbld', 09:04:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:13 INFO - 'MOZ_NO_REMOTE': '1', 09:04:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:13 INFO - 'NO_EM_RESTART': '1', 09:04:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:13 INFO - 'PWD': '/builds/slave/test', 09:04:13 INFO - 'SHELL': '/bin/bash', 09:04:13 INFO - 'SHLVL': '1', 09:04:13 INFO - 'TERM': 'linux', 09:04:13 INFO - 'TMOUT': '86400', 09:04:13 INFO - 'USER': 'cltbld', 09:04:13 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475769828.740062-2084212502', 09:04:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:13 INFO - '_': '/tools/buildbot/bin/python'} 09:04:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:13 INFO - Downloading/unpacking jsonschema==2.5.1 09:04: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 09:04: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 09:04: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 09:04: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 09:04: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 09:04: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 09:04:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:04:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:04: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 09:04: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 09:04: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 09:04: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 09:04: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 09:04: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 09:04:15 INFO - Downloading functools32-3.2.3-2.tar.gz 09:04:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:04:15 INFO - warning: no files found matching '*.txt' 09:04:15 INFO - no previously-included directories found matching 'build' 09:04:15 INFO - no previously-included directories found matching 'dist' 09:04:15 INFO - no previously-included directories found matching '.git*' 09:04:15 INFO - Installing collected packages: jsonschema, functools32 09:04:15 INFO - Running setup.py install for functools32 09:04:15 INFO - warning: no files found matching '*.txt' 09:04:15 INFO - no previously-included directories found matching 'build' 09:04:15 INFO - no previously-included directories found matching 'dist' 09:04:15 INFO - no previously-included directories found matching '.git*' 09:04:15 INFO - Successfully installed jsonschema functools32 09:04:15 INFO - Cleaning up... 09:04:15 INFO - Return code: 0 09:04:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:04:15 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')]} 09:04:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:15 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')]} 09:04:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:15 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 0x7f35e0100f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc1f60>, '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 0x2cc2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc31d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1475769828.740062-2084212502', '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 09:04:15 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 09:04:15 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 09:04:15 INFO - Using env: {'DISPLAY': ':0', 09:04:15 INFO - 'HOME': '/home/cltbld', 09:04:15 INFO - 'LANG': 'en_US.UTF-8', 09:04:15 INFO - 'LANGUAGE': 'en_US:en', 09:04:15 INFO - 'LOGNAME': 'cltbld', 09:04:15 INFO - 'MAIL': '/var/mail/cltbld', 09:04:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:15 INFO - 'MOZ_NO_REMOTE': '1', 09:04:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:15 INFO - 'NO_EM_RESTART': '1', 09:04:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:15 INFO - 'PWD': '/builds/slave/test', 09:04:15 INFO - 'SHELL': '/bin/bash', 09:04:15 INFO - 'SHLVL': '1', 09:04:15 INFO - 'TERM': 'linux', 09:04:15 INFO - 'TMOUT': '86400', 09:04:15 INFO - 'USER': 'cltbld', 09:04:15 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475769828.740062-2084212502', 09:04:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:15 INFO - '_': '/tools/buildbot/bin/python'} 09:04:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:04:16 INFO - Cleaning up... 09:04:16 INFO - Return code: 0 09:04:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:04: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')]} 09:04:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04: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')]} 09:04:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:16 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 0x7f35e0100f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc1f60>, '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 0x2cc2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc31d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1475769828.740062-2084212502', '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 09:04:16 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 09:04:16 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 09:04:16 INFO - Using env: {'DISPLAY': ':0', 09:04:16 INFO - 'HOME': '/home/cltbld', 09:04:16 INFO - 'LANG': 'en_US.UTF-8', 09:04:16 INFO - 'LANGUAGE': 'en_US:en', 09:04:16 INFO - 'LOGNAME': 'cltbld', 09:04:16 INFO - 'MAIL': '/var/mail/cltbld', 09:04:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:16 INFO - 'MOZ_NO_REMOTE': '1', 09:04:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:16 INFO - 'NO_EM_RESTART': '1', 09:04:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:16 INFO - 'PWD': '/builds/slave/test', 09:04:16 INFO - 'SHELL': '/bin/bash', 09:04:16 INFO - 'SHLVL': '1', 09:04:16 INFO - 'TERM': 'linux', 09:04:16 INFO - 'TMOUT': '86400', 09:04:16 INFO - 'USER': 'cltbld', 09:04:16 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475769828.740062-2084212502', 09:04:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:16 INFO - '_': '/tools/buildbot/bin/python'} 09:04:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:16 INFO - Downloading/unpacking blobuploader==1.2.4 09:04:16 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 09:04:16 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 09:04:16 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 09:04:16 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 09:04:16 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 09:04:16 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 09:04:18 INFO - Downloading blobuploader-1.2.4.tar.gz 09:04:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:04:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:04:18 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 09:04:18 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 09:04:18 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 09:04:18 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 09:04:18 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 09:04:18 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 09:04:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:04:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:04:18 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 09:04:18 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 09:04:18 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 09:04:18 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 09:04:18 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 09:04:18 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 09:04:18 INFO - Downloading docopt-0.6.1.tar.gz 09:04:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:04:18 INFO - Installing collected packages: blobuploader, requests, docopt 09:04:18 INFO - Running setup.py install for blobuploader 09:04:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:04:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:04:19 INFO - Running setup.py install for requests 09:04:19 INFO - Running setup.py install for docopt 09:04:19 INFO - Successfully installed blobuploader requests docopt 09:04:19 INFO - Cleaning up... 09:04:19 INFO - Return code: 0 09:04:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:04: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')]} 09:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04: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')]} 09:04:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:19 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 0x7f35e0100f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc1f60>, '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 0x2cc2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc31d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1475769828.740062-2084212502', '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 09:04:19 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 09:04:19 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 09:04:19 INFO - Using env: {'DISPLAY': ':0', 09:04:19 INFO - 'HOME': '/home/cltbld', 09:04:19 INFO - 'LANG': 'en_US.UTF-8', 09:04:19 INFO - 'LANGUAGE': 'en_US:en', 09:04:19 INFO - 'LOGNAME': 'cltbld', 09:04:19 INFO - 'MAIL': '/var/mail/cltbld', 09:04:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:19 INFO - 'MOZ_NO_REMOTE': '1', 09:04:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:19 INFO - 'NO_EM_RESTART': '1', 09:04:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:19 INFO - 'PWD': '/builds/slave/test', 09:04:19 INFO - 'SHELL': '/bin/bash', 09:04:19 INFO - 'SHLVL': '1', 09:04:19 INFO - 'TERM': 'linux', 09:04:19 INFO - 'TMOUT': '86400', 09:04:19 INFO - 'USER': 'cltbld', 09:04:19 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475769828.740062-2084212502', 09:04:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:19 INFO - '_': '/tools/buildbot/bin/python'} 09:04:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:04:19 INFO - Running setup.py (path:/tmp/pip-qIZxLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:04:19 INFO - Running setup.py (path:/tmp/pip-kifD16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:04:19 INFO - Running setup.py (path:/tmp/pip-R7Cs8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:04:19 INFO - Running setup.py (path:/tmp/pip-VMfa7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:04:20 INFO - Running setup.py (path:/tmp/pip-352MVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:04:20 INFO - Running setup.py (path:/tmp/pip-fOr5a1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:04:20 INFO - Running setup.py (path:/tmp/pip-64Pgub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:04:20 INFO - Running setup.py (path:/tmp/pip-FMBrAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:04:20 INFO - Running setup.py (path:/tmp/pip-nHh_3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:04:20 INFO - Running setup.py (path:/tmp/pip-_LS4oQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:04:20 INFO - Running setup.py (path:/tmp/pip-JbdHMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:04:20 INFO - Running setup.py (path:/tmp/pip-ZqRjUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:04:20 INFO - Running setup.py (path:/tmp/pip-8DomUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:04:20 INFO - Running setup.py (path:/tmp/pip-i2tjN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:04:20 INFO - Running setup.py (path:/tmp/pip-RJuvZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:04:20 INFO - Running setup.py (path:/tmp/pip-2fb4hH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:04:20 INFO - Running setup.py (path:/tmp/pip-ozGZj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:04:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:04:20 INFO - Running setup.py install for manifestparser 09:04:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:04:21 INFO - Running setup.py install for mozcrash 09:04:21 INFO - Running setup.py install for mozdebug 09:04:21 INFO - Running setup.py install for mozdevice 09:04:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:04:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:04:21 INFO - Running setup.py install for mozfile 09:04:21 INFO - Running setup.py install for mozhttpd 09:04:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:04:21 INFO - Running setup.py install for mozinfo 09:04:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:04:21 INFO - Running setup.py install for mozInstall 09:04:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:04:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:04:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:04:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:04:21 INFO - Running setup.py install for mozleak 09:04:21 INFO - Running setup.py install for mozlog 09:04:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:04:22 INFO - Running setup.py install for moznetwork 09:04:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:04:22 INFO - Running setup.py install for mozprocess 09:04:22 INFO - Running setup.py install for mozprofile 09:04:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:04:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:04:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:04:22 INFO - Running setup.py install for mozrunner 09:04:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:04:22 INFO - Running setup.py install for mozscreenshot 09:04:22 INFO - Running setup.py install for moztest 09:04:22 INFO - Running setup.py install for mozversion 09:04:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:04:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:04:22 INFO - Cleaning up... 09:04:22 INFO - Return code: 0 09:04:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:04:22 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')]} 09:04:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:22 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')]} 09:04:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:22 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 0x7f35e0100f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc1f60>, '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 0x2cc2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc31d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1475769828.740062-2084212502', '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 09:04:22 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 09:04:22 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 09:04:22 INFO - Using env: {'DISPLAY': ':0', 09:04:22 INFO - 'HOME': '/home/cltbld', 09:04:22 INFO - 'LANG': 'en_US.UTF-8', 09:04:22 INFO - 'LANGUAGE': 'en_US:en', 09:04:22 INFO - 'LOGNAME': 'cltbld', 09:04:22 INFO - 'MAIL': '/var/mail/cltbld', 09:04:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:22 INFO - 'MOZ_NO_REMOTE': '1', 09:04:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:22 INFO - 'NO_EM_RESTART': '1', 09:04:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:22 INFO - 'PWD': '/builds/slave/test', 09:04:22 INFO - 'SHELL': '/bin/bash', 09:04:22 INFO - 'SHLVL': '1', 09:04:22 INFO - 'TERM': 'linux', 09:04:22 INFO - 'TMOUT': '86400', 09:04:22 INFO - 'USER': 'cltbld', 09:04:22 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475769828.740062-2084212502', 09:04:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:22 INFO - '_': '/tools/buildbot/bin/python'} 09:04:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:04:22 INFO - Running setup.py (path:/tmp/pip-kXojg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:04:23 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)) 09:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:04:23 INFO - Running setup.py (path:/tmp/pip-TsdC8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:04:23 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)) 09:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:04:23 INFO - Running setup.py (path:/tmp/pip-q9aTcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:04:23 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)) 09:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:04:23 INFO - Running setup.py (path:/tmp/pip-_SRV4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:04:23 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)) 09:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:04:23 INFO - Running setup.py (path:/tmp/pip-olIg17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:04:23 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)) 09:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:04:23 INFO - Running setup.py (path:/tmp/pip-5xt8nB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:04:23 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)) 09:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:04:23 INFO - Running setup.py (path:/tmp/pip-xdbRT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:04:23 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)) 09:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:04:23 INFO - Running setup.py (path:/tmp/pip-QNuu4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:04:23 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)) 09:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:04:23 INFO - Running setup.py (path:/tmp/pip-vS_yb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:04:23 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)) 09:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:04:23 INFO - Running setup.py (path:/tmp/pip-7rhstc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:04:23 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)) 09:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:04:23 INFO - Running setup.py (path:/tmp/pip-0vPHUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:04:23 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)) 09:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:04:23 INFO - Running setup.py (path:/tmp/pip-AdI_WR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:04:23 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)) 09:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:04:23 INFO - Running setup.py (path:/tmp/pip-zGqbXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:04:23 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)) 09:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:04:23 INFO - Running setup.py (path:/tmp/pip-UiRE0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:04:24 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)) 09:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:04:24 INFO - Running setup.py (path:/tmp/pip-eIaQqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:04:24 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)) 09:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:04:24 INFO - Running setup.py (path:/tmp/pip-tmhDaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:04:24 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)) 09:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:04:24 INFO - Running setup.py (path:/tmp/pip-pBfX1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:04:24 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)) 09:04:24 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)) 09:04:24 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)) 09:04:24 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)) 09:04:24 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)) 09:04:24 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)) 09:04:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:04:24 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 09:04:24 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 09:04:24 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 09:04:24 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 09:04:24 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 09:04:24 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 09:04:26 INFO - Downloading blessings-1.6.tar.gz 09:04:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:04:26 INFO - Installing collected packages: blessings 09:04:26 INFO - Running setup.py install for blessings 09:04:26 INFO - Successfully installed blessings 09:04:26 INFO - Cleaning up... 09:04:26 INFO - Return code: 0 09:04:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:04:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:04:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:04:26 INFO - Reading from file tmpfile_stdout 09:04:26 INFO - Current package versions: 09:04:26 INFO - argparse == 1.2.1 09:04:26 INFO - blessings == 1.6 09:04:26 INFO - blobuploader == 1.2.4 09:04:26 INFO - docopt == 0.6.1 09:04:26 INFO - functools32 == 3.2.3-2 09:04:26 INFO - jsonschema == 2.5.1 09:04:26 INFO - manifestparser == 1.1 09:04:26 INFO - mozInstall == 1.12 09:04:26 INFO - mozcrash == 0.17 09:04:26 INFO - mozdebug == 0.1 09:04:26 INFO - mozdevice == 0.48 09:04:26 INFO - mozfile == 1.2 09:04:26 INFO - mozhttpd == 0.7 09:04:26 INFO - mozinfo == 0.9 09:04:26 INFO - mozleak == 0.1 09:04:26 INFO - mozlog == 3.4 09:04:26 INFO - moznetwork == 0.27 09:04:26 INFO - mozprocess == 0.23 09:04:26 INFO - mozprofile == 0.28 09:04:26 INFO - mozrunner == 6.12 09:04:26 INFO - mozscreenshot == 0.1 09:04:26 INFO - mozsystemmonitor == 0.3 09:04:26 INFO - moztest == 0.7 09:04:26 INFO - mozversion == 1.4 09:04:26 INFO - psutil == 3.1.1 09:04:26 INFO - requests == 1.2.3 09:04:26 INFO - wsgiref == 0.1.2 09:04:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:04:26 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')]} 09:04:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:26 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')]} 09:04:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:26 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 0x7f35e0100f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc1f60>, '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 0x2cc2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc31d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1475769828.740062-2084212502', '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 09:04:26 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 09:04:26 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 09:04:26 INFO - Using env: {'DISPLAY': ':0', 09:04:26 INFO - 'HOME': '/home/cltbld', 09:04:26 INFO - 'LANG': 'en_US.UTF-8', 09:04:26 INFO - 'LANGUAGE': 'en_US:en', 09:04:26 INFO - 'LOGNAME': 'cltbld', 09:04:26 INFO - 'MAIL': '/var/mail/cltbld', 09:04:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:26 INFO - 'MOZ_NO_REMOTE': '1', 09:04:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:26 INFO - 'NO_EM_RESTART': '1', 09:04:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:26 INFO - 'PWD': '/builds/slave/test', 09:04:26 INFO - 'SHELL': '/bin/bash', 09:04:26 INFO - 'SHLVL': '1', 09:04:26 INFO - 'TERM': 'linux', 09:04:26 INFO - 'TMOUT': '86400', 09:04:26 INFO - 'USER': 'cltbld', 09:04:26 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475769828.740062-2084212502', 09:04:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:26 INFO - '_': '/tools/buildbot/bin/python'} 09:04:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:26 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)) 09:04:26 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)) 09:04:26 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)) 09:04:26 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)) 09:04:26 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)) 09:04:26 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)) 09:04:26 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)) 09:04:26 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)) 09:04:26 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)) 09:04:26 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)) 09:04:26 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)) 09:04:26 INFO - Cleaning up... 09:04:26 INFO - Return code: 0 09:04:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:04:26 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')]} 09:04:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:26 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')]} 09:04:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:26 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 0x7f35e0100f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc1f60>, '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 0x2cc2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc31d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1475769828.740062-2084212502', '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 09:04:26 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 09:04:26 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 09:04:26 INFO - Using env: {'DISPLAY': ':0', 09:04:26 INFO - 'HOME': '/home/cltbld', 09:04:26 INFO - 'LANG': 'en_US.UTF-8', 09:04:26 INFO - 'LANGUAGE': 'en_US:en', 09:04:26 INFO - 'LOGNAME': 'cltbld', 09:04:26 INFO - 'MAIL': '/var/mail/cltbld', 09:04:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:26 INFO - 'MOZ_NO_REMOTE': '1', 09:04:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:26 INFO - 'NO_EM_RESTART': '1', 09:04:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:26 INFO - 'PWD': '/builds/slave/test', 09:04:26 INFO - 'SHELL': '/bin/bash', 09:04:26 INFO - 'SHLVL': '1', 09:04:26 INFO - 'TERM': 'linux', 09:04:26 INFO - 'TMOUT': '86400', 09:04:26 INFO - 'USER': 'cltbld', 09:04:26 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475769828.740062-2084212502', 09:04:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:26 INFO - '_': '/tools/buildbot/bin/python'} 09:04:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:04:27 INFO - Cleaning up... 09:04:27 INFO - Return code: 0 09:04:27 INFO - Running post-action listener: _resource_record_post_action 09:04:27 INFO - Running post-action listener: _start_resource_monitoring 09:04:27 INFO - Starting resource monitoring. 09:04:27 INFO - [mozharness: 2016-10-06 16:04:27.118973Z] Finished create-virtualenv step (success) 09:04:27 INFO - [mozharness: 2016-10-06 16:04:27.119523Z] Running install step. 09:04:27 INFO - Running pre-action listener: _resource_record_pre_action 09:04:27 INFO - Running main action method: install 09:04:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:04:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:04:27 INFO - Reading from file tmpfile_stdout 09:04:27 INFO - Detecting whether we're running mozinstall >=1.0... 09:04:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:04:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:04:27 INFO - Reading from file tmpfile_stdout 09:04:27 INFO - Output received: 09:04:27 INFO - Usage: mozinstall [options] installer 09:04:27 INFO - Options: 09:04:27 INFO - -h, --help show this help message and exit 09:04:27 INFO - -d DEST, --destination=DEST 09:04:27 INFO - Directory to install application into. [default: 09:04:27 INFO - "/builds/slave/test"] 09:04:27 INFO - --app=APP Application being installed. [default: firefox] 09:04:27 INFO - mkdir: /builds/slave/test/build/application 09:04:27 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'] 09:04:27 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 09:04:43 INFO - Reading from file tmpfile_stdout 09:04:43 INFO - Output received: 09:04:43 INFO - /builds/slave/test/build/application/firefox/firefox 09:04:43 INFO - Running post-action listener: _resource_record_post_action 09:04:43 INFO - [mozharness: 2016-10-06 16:04:43.578162Z] Finished install step (success) 09:04:43 INFO - [mozharness: 2016-10-06 16:04:43.578407Z] Running run-tests step. 09:04:43 INFO - Running pre-action listener: _resource_record_pre_action 09:04:43 INFO - Running main action method: run_tests 09:04:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:04:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:04:43 INFO - Python 2.7.3 09:04:43 INFO - Return code: 0 09:04:43 INFO - grabbing minidump binary from tooltool 09:04:43 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')]} 09:04:43 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 0x2cc1f60>, '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 0x2cc2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc31d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:04:43 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 09:04:43 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 09:04:43 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 09:04:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:04:43 INFO - Return code: 0 09:04:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:04:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:04:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:04:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:04:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:04:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aKZ051ddRCWuDppQ2Nakqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:04:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aKZ051ddRCWuDppQ2Nakqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:04:43 INFO - Using env: {'DISPLAY': ':0', 09:04:43 INFO - 'HOME': '/home/cltbld', 09:04:43 INFO - 'LANG': 'en_US.UTF-8', 09:04:43 INFO - 'LANGUAGE': 'en_US:en', 09:04:43 INFO - 'LOGNAME': 'cltbld', 09:04:43 INFO - 'MAIL': '/var/mail/cltbld', 09:04:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:04:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:04:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:43 INFO - 'MOZ_NO_REMOTE': '1', 09:04:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:04:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:43 INFO - 'NO_EM_RESTART': '1', 09:04:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:43 INFO - 'PWD': '/builds/slave/test', 09:04:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:04:43 INFO - 'SHELL': '/bin/bash', 09:04:43 INFO - 'SHLVL': '1', 09:04:43 INFO - 'TERM': 'linux', 09:04:43 INFO - 'TMOUT': '86400', 09:04:43 INFO - 'USER': 'cltbld', 09:04:43 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1475769828.740062-2084212502', 09:04:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:43 INFO - '_': '/tools/buildbot/bin/python'} 09:04:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aKZ051ddRCWuDppQ2Nakqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:04:43 INFO - mozversion application_buildid: 20161006074200 09:04:43 INFO - mozversion application_changeset: d382e432aa089d0aec8300da50076faddf708701 09:04:43 INFO - mozversion application_display_name: Nightly 09:04:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:04:43 INFO - mozversion application_name: Firefox 09:04:43 INFO - mozversion application_remotingname: firefox 09:04:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 09:04:43 INFO - mozversion application_vendor: Mozilla 09:04:43 INFO - mozversion application_version: 52.0a1 09:04:43 INFO - mozversion platform_buildid: 20161006074200 09:04:43 INFO - mozversion platform_changeset: d382e432aa089d0aec8300da50076faddf708701 09:04:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 09:04:43 INFO - mozversion platform_version: 52.0a1 09:04:43 INFO - using testdate: 1475769883 09:04:43 INFO - actual date: 1475769883 09:04:43 INFO - starting webserver on 'localhost:40648' 09:04:43 INFO - SUITE-START | Running 2 tests 09:04:43 INFO - TEST-START | dromaeo_css 09:04:43 INFO - operating with platform_type : linux_ 09:04:43 INFO - Initialising browser for dromaeo_css test... 09:04:43 INFO - TEST-INFO | started process 27230 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvTdlSy/profile http://localhost:40648/getInfo.html) 09:04:48 INFO - PROCESS | 27230 | __metrics Screen width/height:1600/1200 09:04:48 INFO - PROCESS | 27230 | colorDepth:24 09:04:48 INFO - PROCESS | 27230 | Browser inner width/height: 1024/697 09:04:48 INFO - PROCESS | 27230 | __metrics 09:04:49 ERROR - PROCESS | 27230 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 09:04:50 INFO - TEST-INFO | 27230: exit 0 09:04:50 INFO - Browser initialized. 09:04:50 INFO - Running cycle 1/1 for dromaeo_css test... 09:04:50 INFO - TEST-INFO | started process 27350 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvTdlSy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:05:02 INFO - PROCESS | 27350 | RSS: Main: 186966016 09:05:02 INFO - PROCESS | 27350 | 09:05:52 INFO - PROCESS | 27350 | 1475769952066 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] 09:08:06 INFO - PROCESS | 27350 | Cycle 1(1): loaded http://localhost:40648/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40648/tests/dromaeo/cssquery-ext.html) 09:08:08 INFO - PROCESS | 27350 | RSS: Main: 200081408 09:08:08 INFO - PROCESS | 27350 | 09:11:10 INFO - PROCESS | 27350 | Cycle 1(1): loaded http://localhost:40648/tests/dromaeo/cssquery-ext.html (next: http://localhost:40648/tests/dromaeo/cssquery-jquery.html) 09:11:11 INFO - PROCESS | 27350 | RSS: Main: 202473472 09:11:11 INFO - PROCESS | 27350 | 09:14:13 INFO - PROCESS | 27350 | Cycle 1(1): loaded http://localhost:40648/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40648/tests/dromaeo/cssquery-mootools.html) 09:14:13 INFO - PROCESS | 27350 | RSS: Main: 199544832 09:14:13 INFO - PROCESS | 27350 | 09:17:15 INFO - PROCESS | 27350 | Cycle 1(1): loaded http://localhost:40648/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40648/tests/dromaeo/cssquery-prototype.html) 09:17:16 INFO - PROCESS | 27350 | RSS: Main: 195817472 09:17:16 INFO - PROCESS | 27350 | 09:20:19 INFO - PROCESS | 27350 | Cycle 1(1): loaded http://localhost:40648/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40648/tests/dromaeo/cssquery-yui.html) 09:20:19 INFO - PROCESS | 27350 | RSS: Main: 199577600 09:20:19 INFO - PROCESS | 27350 | 09:23:22 INFO - PROCESS | 27350 | Cycle 1(1): loaded http://localhost:40648/tests/dromaeo/cssquery-yui.html (next: http://localhost:40648/tests/dromaeo/cssquery-dojo.html) 09:23:22 INFO - PROCESS | 27350 | RSS: Main: 199499776 09:23:22 INFO - PROCESS | 27350 | 09:23:22 INFO - PROCESS | 27350 | __start_tp_report 09:23:22 INFO - PROCESS | 27350 | _x_x_mozilla_page_load 09:23:22 INFO - PROCESS | 27350 | _x_x_mozilla_page_load_details 09:23:22 INFO - PROCESS | 27350 | |i|pagename|runs| 09:23:22 INFO - PROCESS | 27350 | |0;dojo.html;2617.057859170698;2629.2112366290107;2636.525425423424;2653.8938442462304;2656.827306225096;4603;4751.216049351857;4752.144613969488;4776.928346074807;4812.302216178652;4671.509491503394;4780.139574876521;4809.591184749301;4827.46897841238;4835.734034628094;4366.432363792718;4414.095110502355;4452.97773511132;4491.056878055612;4560.8403705870305;4431.1802316571375;4460.353248778925;4471.374007638933;4494.943688233279;4500.392447019643;4292.506361768405;4332.350147477872;4381.298992161239;4419.359192917042;4462.241418958753;4405.933910991338;4423.911521769546;4449.26587113126;4468.8882777930485;4480.641548676098;4386.7367957922625;4404.823807047715;4420.07178492517;4426.756528390937;4473.664475164375;4663;4690.742009189493;4757.1437141314545;4810.975945120252;4850.393700787402;5117.820876269313;5163.5352818246165;5163.5352818246165;5234.16253399458;5236.6857988520815;5178.508041736029;5195.2986346843445;5204.9479505204845;5207.817726379559;5253.711045892474;4726.432828060655;4785.258284965836;4836.226203807374;4837.540433658797;4844.370231869834;5183.792648294026;5211.5830733541225;5217.478252174752;5237.947620523746;5302.522772950376;5021.297018417425;5025.748712564357;5026.29631851541;5027.798888044437;5093.490650934951;4950.851474455772;5028.949710502921;5100.515451032146;5127.1540195867265;5177.58579313654;5135.7432128394175;5150.27896094547;5150.974245128826;5191.636585438983;5201.661891977009;5104.846854594368;5112.769925353294;5128.230765385148;5138.332016837787;5182.870428239325;4271.31658934569;4322.654187664979;4328.43730315057;4406.7576283304725;4478.596926276651;3788.4885540452237;3815.6565909068318;3849.2301539692176;3850.0759817643566;3857.286402015636;4357.477102747627;4376.540463251376;4404.163208990281;4408.360787685768;4440.4005459263235;5107.719075450812;5127.359080114986;5132.974335128375;5172.120739474299;5193.324867767166;4280.165367753259;4397.1865204937185;4400.22995975703;4406.7576283304725;4444.044530425974;4524.502304746476;4547.090581883636;4566.840160594364;4567.314902764612;4646.767661616906;4700.95299047012;4731.006488637425;4740.265258884879;4745.715257084586;4793.257045158006;5090.669106508065;5097.745112744422;5098.847034588968;5104.1067813133295;5109.718965456936;4646.814127435;4668.276417155346;4669.7431641260055;4696.600788932979;4707.129181101507;4974.37820272466;4975.726335051462;4976.154053810788;4978;5037.420696619935;5007.974960125322;5009.148444764326;5017.071841709296;5019.799208031638;5080.923786143137;4804.6876952997945;4834.927476087792;4902.534259245366;4918.532739389752;4967.82612608557;4935.901281974412;4939.901201975868;4968.3292755479;5000.199968005247;5019.447860735389;4797.95202047989;4886.609071274361;4906.6320025997475;4910.533499317559;4930.408350997904;4884.755762211947;4974.353334066548;4990.850274491771;4991.725455100004;5010.949890501049;4780.091782561302;4811.615070794258;4835.564799168092;4890.926636100533;4894.363732714724 09:23:22 INFO - PROCESS | 27350 | |1;ext.html;539.2639047699888;551.010935371009;561.1414535760288;566.1196838915486;580.2688612348439;37037.44443833345;39050.21899562007;39131.413028804556;41894;41952.16095678085;39171;39706;39717.60282397175;39733.20533589327;39742.602573974254;7475.514091584043;7645.808854778619;7673.577953212571;7673.846523069536;7731.22687731228;7639.3124618784295;7713.498622589514;7720.80327549228;7727.497712648688;7733.613319334039;7705.537667739954;7710.498817576868;7733.8066548336465;7740.729074482394;7741.380689544823;7509.9624501877415;7526.322630963185;7542.6605802739;7545.773626791205;7547.169811320723;7653.311201991847;7714.151443341228;7721.459497835153;7723.806904827368;7749.9225007749765;36394.45408318877;36596.0850978725;36691.266174676624;36772.44841327382;36797.63202367996;2560.590305551103;2623.6720409948757;2651.1287698225033;2655.6016597510334;2773.362126710868;27052.59421108685;27220.638968051717;27338.726612733815;27355.316117097034;27708.168754937386;3043.3508643851364;3141.2618034761813;3154.921126971821;3156.6054243219596;3178.8410579471165;230068;231064.9999999983;231142;231245;231282;47335.76332118317;47807.282890756665;47817.521824782;47890.28164577534;47939;49228.26157607639;49331.50668493341;49735.502644973814;49933;49950.50049499459;11783.528658853722;11846.407679615984;11977.700557486132;12045.819312710317;12050.09624278165;7893.684252629945;7916.287534121957;7948.721794737156;7967.56178410193;8034.799130021796;13036.934815326053;14029.579112626638;14114.788278175836;14178.220197889008;14370.209638469776;5731.312242530923;5746.5977381583725;5749.453801888814;5763.3200561738995;5965.9105113422465;771.8494893495827;847.9745607631781;887.3655336434481;904.3669431398048;948.4498990585444;26561.734382656312;26933.595996060074;27107.728922710914;27297.590536141975;27631.861840690668;904.5251243097294;960.3661583355092;964.3394274921701;983.2822039910905;1002.4135880509838;13823.170609763447;13911.721765564633;14013.859861401255;14189.716205675828;14237;358869;362040;362731;363246;363654;44907.32639010417;45212.3218151728;45380;45397.319040214425;45434;1140.1619809440056;1162.587281515067;1173.524722487394;1180.4628893853276;1182.9053675705923;23710.52578948377;24372.5782414307;25372.873135634203;25650.743492565583;25694.357641059123;38315.808420957714;38700.2259954805;38743.2251354977;38848.41727374035;39002.804985974886;265453;265676;265809;314425;314567;22728.772712272665;22921.426964326027;23222.535549289256;23230.070797167926;23299;38422.423663645626;38480.422793658676;39085.41371879481;39106.41340379953;39113.608863910995;33233.927940217596;33434.33131337408;33630.159246019044;33803.83098084494;34098;32872.671273286964;32978.505322420664;32978.83510582432;33373.16567085745;33676.831615841766;27911.720882791724;28443.146705598865;32535.674643253264;33468.49797253092;33508;25522.489550209262;29608.407831843673;30674.625791162507;30704.846475767477;30946.84526577353;24235.39411514726;24546.802982489353;24588.557601935387;24785.50428991374;24821.50356992886 09:23:22 INFO - PROCESS | 27350 | |2;jquery.html;336.63475129484493;350.3431066749844;350.97192224622034;354.83854846045045;371.0371585735018;15383.69232615347;15790.052596844183;16620.168991550403;16747.246373913174;16764.748528772077;14885.702285954274;15198.54404367868;15350;15491;16011.35954561819;4586.334981427691;4599.2752717730855;4681.485036645966;4699.154152252593;4741.336212930192;4571.131485017836;4660.137874493213;4663.626909847204;4665.300204969248;4670.719756814585;4566.474855391622;4666.743329116897;4692.601128904047;5124.359455068116;5180.041692286939;5111.51440613143;5161.045206636765;5164;5169.56058735008;5179.326687530634;4491.573300536444;4623.86128416148;4646.953530464686;4655.6973796703105;4667.369905062807;18862.905685471622;19046.80953190464;19354.225830966745;19977.400677979684;20373.796262037336;1743.5902562897709;1867.0851282871295;1909.9045047747557;1941.7378653881685;2033.4916270932267;8539.786505337353;8873.157050080232;8983.865242021375;9045.185933265971;9378;1702.5403141151944;1723.4571110100278;1749.658816530777;1756.1482680899753;1782.6880295948158;64787.67606161986;67950.980735289;68472.31527684709;69786;69979.65010174917;9810.362326448758;9857.40855548655;9859.161971232526;10007.699769006942;10167.542460589291;13595.456181752817;13601.183928964096;13602.115862468909;13608.93195534016;13645.181289122684;6421.3578642136345;6498.772542960974;6586.8353291168105;6624.105745724362;6769.966150169218;5604.243427137284;5839.065749480063;5903.203067585821;5956.434138756811;6145.600535965148;4048.8785336439955;4098.672106231495;4129.545749967501;4147.564505726916;4247.617714405656;1777.8044415114327;1820.1627251464474;1841.5580260737327;1874.0910658330972;1893.365722482956;810.9878351824727;816.8243827577099;861.6553378648591;876.548577482597;879.4767113567417;16160.595985100466;17162.914185428992;17177.398791042255;17433.21550530229;17685.292588296325;815.995920020396;839.1817977471916;845.9619317130744;862.1421685423044;878.5124256037833;9248.861267081;9679.177269931994;9840.3603765755;9842.60629574809;9990.350627209207;336493;350384;350397;350727;351087;83184.58407707923;84052;84072.57963710265;85175.574122129;86307;890.888638920135;908.0828363352929;936.6908920056366;941.7127776028377;944.1078181118777;15578.454754083552;15677.921610391875;15913.363465461252;16197.51407457778;16230.269637866088;27429.58855617207;36233.81883090568;37168.25663486769;37280.44079338866;37958.430623540116;51639.74180129075;51859.74070129625;51939.220911685596;52423;52640.47359526356;7428.7585331005175;7668.57822819728;7707.499012564165;7771.8834217485655;7834.960825195838;11399.259048161843;11946.581869634521;11987.40062996864;12092.516299347928;12832.101752877208;9704.660336888175;9981.301308908307;10065.144462720751;10090.8486372703;10384.636537721144;10026.749331266778;10033.347832390871;10182.592696292066;10357.741056473347;10535.525901334611;9740.464274464972;9975.3017288792;10063.798724025331;10227.642032528825;10473.057424831803;7390.334869861738;7579.583122928292;7614.9719787827935;7644.426667999811;7766.728164514215;9055.411398259092;10089.848652270075;10359.689209323733;10384.636537721144;10408.271421000458 09:23:22 INFO - PROCESS | 27350 | |3;mootools.html;1350.0684527675903;1359.109783092075;1377.7313423882345;1413.6253892718437;1420.9218492982889;6634.402903738663;6866.828329291758;6910.17077950646;7486.513376630522;7510.098788145423;6730;6898.689558969846;6926.653667316639;7132.714691412337;7151.678174482147;2110.229766135361;2123.203798575534;2140.860844045132;2141.4004078857943;2142.657174852024;2011.0045527463926;2021.2117274263048;2034.5829105033433;2059.2483743433613;2093.7278153840057;2083.312506872736;2101.086027578001;2111.9472013199716;2124.1184908263053;2131.8187954023847;1995.5809280051208;1997.6603977323816;2004.859659823813;2011.3965810257012;2015.1838505405187;1996.790337014607;2024.038581673708;2047.119738512439;2047.392796654619;2056.5886822635534;7378.557286562824;7395.889061664079;7401.814954626124;7430.182679905206;7443.404527637776;4084.6732261419015;4197.370394440828;4206.642435392995;4207.158568286324;4209.2423363794505;2632.565626671597;2719.9120351859215;2741.6984131745494;2745.149003808806;2776.278167676419;814.4665244265016;814.5072231300037;822.5311572403732;828.7555171224443;828.9626966786449;9780.755481112958;9825.164860986753;9826.90173098267;9930.404175749478;10025.298229124037;3723.255348930171;3764.698824094066;3936.1340505088833;3938.6849052076336;3959.742616729903;7794.571298578632;7810.609469526615;7825.217478252129;7829.882551761728;7861.2531809478005;4217.472815898012;4227.767472788964;4234.153169366139;4237.87286381409;4245.426867372927;3272.2310257089566;3393.6606339365867;3614.475900994341;3851.422286657024;3856.267309211297;3108.704673056056;3131.091983324856;3222.7421806255443;3230.8384580770867;3258.4460641690494;981.190517822799;982.4498280962683;1000.6297669862198;1004.4073996342194;1015.4770293298957;612.4487960835284;724.8535398669405;736.9005184300158;740.2523451314104;749.4192001199115;4560.4071470708595;4622.953770462253;4634.559716826896;4712.528747125329;4798.95201047992;365.1710616899623;369.81878879348926;370.70899344014816;373.8616711816645;376.38836890053665;3105.9534106988413;3180.80915145092;3183.108729555728;3208.7753857230236;3222.468292731673;8490.915090849012;8837.60230789616;8863.64545418189;8936.32977526688;8940.32947528938;8839.955800220958;8873.689420870238;8877.289816814638;8942.195202431813;8943.329250306253;6854.828629284308;6884.380405763405;6943.305669433016;6953.582785032813;6960.9303906961295;4730.596695743878;4779.832705855418;4792.424909010941;4826.758662066813;4830.203016502238;7936.444448888522;7942.086660033939;8000.759977200693;8048.114707382067;8115.431919765796;7956.681732730626;8071.677132914618;8141.552214628252;8148.266656000988;8176.713815016446;5451.400345961862;5902.822915312548;6109.389061093855;6147.815565533041;6265.467435268053;6274.341194174728;6565.934340656532;6838.555493892881;6861.725530978904;6985.755498557729;6262.718177681924;6291.370862913672;6348.968255158879;6371.362863713592;6484.059811327425;6141.232345956755;6207.689615519296;6208.751649934133;6219.782307619212;6304.653244071436;5643.746031428677;5664.943350566442;5740.0815869460685;5747.109198074138;5798.376454592552;4241.91516169681;4339.435873336446;4384.714993525411;4460.041091165415;4628.35203071577;4364.432623758891;4394.890127746832;4426.9778651106535;4429.557044295545;4530 09:23:22 INFO - PROCESS | 27350 | |4;prototype.html;282.12822378849353;283.77865265093226;284.2424937541452;285.1459877666388;289.43704494757696;5058.671186372888;5124.9487505124935;5132.153194722866;5143.562797162241;5148.871278218046;4963.900721985558;4995;5022.899542009158;5038.748062596874;5047.621428392867;3639.363111455498;3760.247950409915;3768.9811550942345;3854.614538546137;3881.2237552489473;3874.728768986172;3889.124946886956;3894.7731464588705;3899.551551571563;3908.17928235071;3863.98068009661;3886.24218277436;3889;3895.7857317847506;3906.4921560197276;3819.8472061117523;3834.1373191032076;3845.4231865220163;3910.432987216866;3931.862384816532;3377.8986630401128;3384.76306658534;3385.3567822113964;3389.57630296213;3391.287829555796;4847.636427267934;4889.608831293488;4908.631852611068;4923.532264434873;4926.11329960607;4403.735775853427;4477.238869392211;4480.955190448119;4485.093835120061;4486.641068714495;4953.4303555091265;5274.760431298641;5275.551578115865;5311.442298558673;5316.149416093406;3658.506101676266;3659.743817932746;3662.531711312195;3666.7616604920863;3668.926621467556;5480.698561579152;5491.203775452577;5540.418256083134;5551.557314781483;5566.610337276392;3569.625189355132;3652.392947103266;3652.726045546595;3667.5598928128798;3673.430618254175;3706.1475860552223;3722.218334149859;3729.9254014920093;3735.9626403736156;3743.2513497300647;4335.653147748172;4349.26062569364;4352.325389564622;4358.607725304674;4371.431713877176;5153.922691159635;5206.609504287194;5263;5268.446813084647;5325.627206095536;1276.6042526816716;1286.8713128687057;1287.9678008049873;1289.1878116786365;1289.4777615065914;780.4926797581504;813.2396209543977;813.5200231863229;814.1166833985193;816.6161903905155;4421.943796134813;4486.573775491323;4552.590266875931;4605.907881842411;4625.861224163214;5420.24116623673;5464.480874316933;5470.64440811346;5473.808416705396;5474.91787623186;4610.884727881829;4626.21354369758;4631.467381251199;4632;4634.745089020136;2706.526357887362;2896.3628001839984;2899.97100028997;2904.7385735283924;2907.578401131824;5054.21659642756;5055.848324550269;5062.544371006554;5069.721165335868;5083.542481176712;5337.306150200527;5524.889502209933;5560.833175004756;5567.331920169606;5569.407732012829;5013.398392193033;5022.4977502249485;5022.799088036438;5031.295618613397;5041.092603331435;5443.421407791696;5444.923618155729;5460.3993560707495;5463.207834863843;5495.313085864267;5097.311862898461;5320;5343.438938911514;5345.1714984177515;5361.919571206357;5065.518775716301;5069.172774555334;5094.140638666786;5126.615503837153;5127.6410651254055;3721.5534135903863;3742.812859357076;3748.1191919898256;3749.9250014999;3757.2297678975197;5217.791058499071;5485.4788795064405;5486.972565137149;5487.204355368529;5511;5333.146696528537;5337.279467272024;5378.462153784591;5379.946200538101;5399.082156033405;5325.653832500875;5333.386660534088;5386.8383948481605;5393.703346315833;5403.0544654686055;5115.846524604268;5204.921926171186;5215.45237750046;5253.50091741284;5262.631915573959;5044.772985215601;5186.325777648882;5197.4282828889545;5336.626436149432;5373.462653734751;5181.715005674724;5190.429052804264;5218.530332269962;5236.659617124875;5255.818835183356 09:23:22 INFO - PROCESS | 27350 | |5;yui.html;540.7458494507582;546.9097598896183;559.490863314384;580.550073692888;670.5239280111123;10779.622713205039;11656.592019279327;11712.941435292812;11720.120990925694;11786.351750653721;11488.827667584972;11642;11643.592474263403;11648.126390520703;11657.358845263507;729.9744508942175;748.9700411983514;752.2740555364072;753.8454616803542;757.5189754505873;723.3995783499682;747.237817426225;753.4650398217273;756.4553521464564;760.8250102476434;806.6329819931917;811.37524106438;811.4441607498852;811.5942028985507;811.6266517401973;796.80079980005;799.0890384961149;800.5396896784372;804.0311424733183;804.0351578106296;595.0627761276007;596.9791057313016;597.0387675841891;597.9162917191596;598.267122774602;12364.44360003802;12464.189827661263;12471.875281247252;12477.438515266835;12493.75012499754;12583.245005299712;12650.873491265154;13039.478420863154;13047.282399468026;13838.238896860668;9882;9964.451955142464;9986.101250887383;10123.240756943258;10376.429296388771;3216.083416226364;3217.9517307240176;3228.531862879869;3260.3805276997296;3288.2601414681744;61854.381456185314;62000.37999620036;62945.68527157335;63111.684441577956;64035;10006.69979900604;10071.59713611462;10180.134688551556;10245.948770256102;10428.113610343205;16005.519834404986;16472.023357197213;16501.504954851374;18575.16411761474;18625;6200.224971878515;6528.575642583217;6575.967120164369;6590.47276217911;6607.669616519155;3368.1916340078205;3372.274960883373;3384;3405.4551271796395;3548.2371290172737;2733.603627474005;2832.5467925132293;2842.9004984825433;2844.5590933405356;2845.857707114636;475.25385145321513;481.3670023918536;485.7886819233645;486.7444591589444;497.534804957366;450.32001677466604;484.7333966318581;498.5039885314063;498.57122874328047;518.4970578538812;7417.9985701929545;7465.962670186615;7518.398528117737;7540.434467414966;7754.534727916343;469.69235150976164;493.26257245418327;503.96724212926773;506.34175571757305;511.10046318479;3535.275268569937;3572.678458938708;3732.5520937487677;3746.1758413149064;3854.6338097880657;55605.165922511194;98558;100047;108678;109336;85873;86556.56721716477;87185;90645.54677226572;91433.54283228674;60067;75089.62455187799;77502.61248693833;79000.6049969758;79187;7091.468139889425;7295.635218238961;7502.699892004259;7519.43604229674;7559.962200188964;45753.54246457493;46142.53857461383;47036.52963470321;47215.527844722485;47361.52638473571;50412.495875042245;58257.4174258269;59567;67891.3210867885;69304.30695692978;9834.459104749307;9920;10088.243381746544;10980.286281391684;11119.944400277947;12460.376981151088;12496.625101246613;12501.874981250072;12644.178128421623;12842.293673848028;11307;11433.142514311627;11712.084982752964;11969.102317326062;12757.8086328707;11710.882891170979;11765.705857353634;11821.645350639494;11984.700382490508;12387.19483233587;10858.457077145953;11578.073754099483;11617.419129043345;11878.762424751629;12126.60544037447;9033.593488293174;9678.467684277432;9874.160696340892;9894.50527473609;9914.603415863285;8802.310954660776;8838.381313308008;9276.768080798034;9761.335204430638;9895.703128906145 09:23:22 INFO - PROCESS | 27350 | __end_tp_report 09:23:22 INFO - PROCESS | 27350 | __start_cc_report 09:23:22 INFO - PROCESS | 27350 | _x_x_mozilla_cycle_collect,339 09:23:22 INFO - PROCESS | 27350 | __end_cc_report 09:23:22 INFO - PROCESS | 27350 | __startTimestamp1475771002909__endTimestamp 09:23:22 INFO - PROCESS | 27350 | 09:23:22 INFO - PROCESS | 27350 | ------- Summary: start ------- 09:23:22 INFO - PROCESS | 27350 | Number of tests: 6 09:23:22 INFO - PROCESS | 27350 | 09:23:22 INFO - PROCESS | 27350 | [#0] dojo.html Cycles:165 Average:4718.85 Median:4812.30 stddev:493.28 (10.3%) stddev-sans-first:466.43 09:23:22 INFO - PROCESS | 27350 | Values: 2617.1 2629.2 2636.5 2653.9 2656.8 4603.0 4751.2 4752.1 4776.9 4812.3 4671.5 4780.1 4809.6 4827.5 4835.7 4366.4 4414.1 4453.0 4491.1 4560.8 4431.2 4460.4 4471.4 4494.9 4500.4 4292.5 4332.4 4381.3 4419.4 4462.2 4405.9 4423.9 4449.3 4468.9 4480.6 4386.7 4404.8 4420.1 4426.8 4473.7 4663.0 4690.7 4757.1 4811.0 4850.4 5117.8 5163.5 5163.5 5234.2 5236.7 5178.5 5195.3 5204.9 5207.8 5253.7 4726.4 4785.3 4836.2 4837.5 4844.4 5183.8 5211.6 5217.5 5237.9 5302.5 5021.3 5025.7 5026.3 5027.8 5093.5 4950.9 5028.9 5100.5 5127.2 5177.6 5135.7 5150.3 5151.0 5191.6 5201.7 5104.8 5112.8 5128.2 5138.3 5182.9 4271.3 4322.7 4328.4 4406.8 4478.6 3788.5 3815.7 3849.2 3850.1 3857.3 4357.5 4376.5 4404.2 4408.4 4440.4 5107.7 5127.4 5133.0 5172.1 5193.3 4280.2 4397.2 4400.2 4406.8 4444.0 4524.5 4547.1 4566.8 4567.3 4646.8 4701.0 4731.0 4740.3 4745.7 4793.3 5090.7 5097.7 5098.8 5104.1 5109.7 4646.8 4668.3 4669.7 4696.6 4707.1 4974.4 4975.7 4976.2 4978.0 5037.4 5008.0 5009.1 5017.1 5019.8 5080.9 4804.7 4834.9 4902.5 4918.5 4967.8 4935.9 4939.9 4968.3 5000.2 5019.4 4798.0 4886.6 4906.6 4910.5 4930.4 4884.8 4974.4 4990.9 4991.7 5010.9 4780.1 4811.6 4835.6 4890.9 4894.4 09:23:22 INFO - PROCESS | 27350 | 09:23:22 INFO - PROCESS | 27350 | [#1] ext.html Cycles:180 Average:43623.61 Median:200024.23 stddev:78469.85 (39.2%) stddev-sans-first:78623.31 09:23:22 INFO - PROCESS | 27350 | Values: 539.3 551.0 561.1 566.1 580.3 37037.4 39050.2 39131.4 41894.0 41952.2 39171.0 39706.0 39717.6 39733.2 39742.6 7475.5 7645.8 7673.6 7673.8 7731.2 7639.3 7713.5 7720.8 7727.5 7733.6 7705.5 7710.5 7733.8 7740.7 7741.4 7510.0 7526.3 7542.7 7545.8 7547.2 7653.3 7714.2 7721.5 7723.8 7749.9 36394.5 36596.1 36691.3 36772.4 36797.6 2560.6 2623.7 2651.1 2655.6 2773.4 27052.6 27220.6 27338.7 27355.3 27708.2 3043.4 3141.3 3154.9 3156.6 3178.8 230068.0 231065.0 231142.0 231245.0 231282.0 47335.8 47807.3 47817.5 47890.3 47939.0 49228.3 49331.5 49735.5 49933.0 49950.5 11783.5 11846.4 11977.7 12045.8 12050.1 7893.7 7916.3 7948.7 7967.6 8034.8 13036.9 14029.6 14114.8 14178.2 14370.2 5731.3 5746.6 5749.5 5763.3 5965.9 771.8 848.0 887.4 904.4 948.4 26561.7 26933.6 27107.7 27297.6 27631.9 904.5 960.4 964.3 983.3 1002.4 13823.2 13911.7 14013.9 14189.7 14237.0 358869.0 362040.0 362731.0 363246.0 363654.0 44907.3 45212.3 45380.0 45397.3 45434.0 1140.2 1162.6 1173.5 1180.5 1182.9 23710.5 24372.6 25372.9 25650.7 25694.4 38315.8 38700.2 38743.2 38848.4 39002.8 265453.0 265676.0 265809.0 314425.0 314567.0 22728.8 22921.4 23222.5 23230.1 23299.0 38422.4 38480.4 39085.4 39106.4 39113.6 33233.9 33434.3 33630.2 33803.8 34098.0 32872.7 32978.5 32978.8 33373.2 33676.8 27911.7 28443.1 32535.7 33468.5 33508.0 25522.5 29608.4 30674.6 30704.8 30946.8 24235.4 24546.8 24588.6 24785.5 24821.5 09:23:22 INFO - PROCESS | 27350 | 09:23:22 INFO - PROCESS | 27350 | [#2] jquery.html Cycles:180 Average:23085.76 Median:4592.81 stddev:57987.97 (1262.6%) stddev-sans-first:58125.48 09:23:22 INFO - PROCESS | 27350 | Values: 336.6 350.3 351.0 354.8 371.0 15383.7 15790.1 16620.2 16747.2 16764.7 14885.7 15198.5 15350.0 15491.0 16011.4 4586.3 4599.3 4681.5 4699.2 4741.3 4571.1 4660.1 4663.6 4665.3 4670.7 4566.5 4666.7 4692.6 5124.4 5180.0 5111.5 5161.0 5164.0 5169.6 5179.3 4491.6 4623.9 4647.0 4655.7 4667.4 18862.9 19046.8 19354.2 19977.4 20373.8 1743.6 1867.1 1909.9 1941.7 2033.5 8539.8 8873.2 8983.9 9045.2 9378.0 1702.5 1723.5 1749.7 1756.1 1782.7 64787.7 67951.0 68472.3 69786.0 69979.7 9810.4 9857.4 9859.2 10007.7 10167.5 13595.5 13601.2 13602.1 13608.9 13645.2 6421.4 6498.8 6586.8 6624.1 6770.0 5604.2 5839.1 5903.2 5956.4 6145.6 4048.9 4098.7 4129.5 4147.6 4247.6 1777.8 1820.2 1841.6 1874.1 1893.4 811.0 816.8 861.7 876.5 879.5 16160.6 17162.9 17177.4 17433.2 17685.3 816.0 839.2 846.0 862.1 878.5 9248.9 9679.2 9840.4 9842.6 9990.4 336493.0 350384.0 350397.0 350727.0 351087.0 83184.6 84052.0 84072.6 85175.6 86307.0 890.9 908.1 936.7 941.7 944.1 15578.5 15677.9 15913.4 16197.5 16230.3 27429.6 36233.8 37168.3 37280.4 37958.4 51639.7 51859.7 51939.2 52423.0 52640.5 7428.8 7668.6 7707.5 7771.9 7835.0 11399.3 11946.6 11987.4 12092.5 12832.1 9704.7 9981.3 10065.1 10090.8 10384.6 10026.7 10033.3 10182.6 10357.7 10535.5 9740.5 9975.3 10063.8 10227.6 10473.1 7390.3 7579.6 7615.0 7644.4 7766.7 9055.4 10089.8 10359.7 10384.6 10408.3 09:23:22 INFO - PROCESS | 27350 | 09:23:22 INFO - PROCESS | 27350 | [#3] mootools.html Cycles:180 Average:4687.35 Median:4795.69 stddev:2637.44 (55.0%) stddev-sans-first:2632.92 09:23:22 INFO - PROCESS | 27350 | Values: 1350.1 1359.1 1377.7 1413.6 1420.9 6634.4 6866.8 6910.2 7486.5 7510.1 6730.0 6898.7 6926.7 7132.7 7151.7 2110.2 2123.2 2140.9 2141.4 2142.7 2011.0 2021.2 2034.6 2059.2 2093.7 2083.3 2101.1 2111.9 2124.1 2131.8 1995.6 1997.7 2004.9 2011.4 2015.2 1996.8 2024.0 2047.1 2047.4 2056.6 7378.6 7395.9 7401.8 7430.2 7443.4 4084.7 4197.4 4206.6 4207.2 4209.2 2632.6 2719.9 2741.7 2745.1 2776.3 814.5 814.5 822.5 828.8 829.0 9780.8 9825.2 9826.9 9930.4 10025.3 3723.3 3764.7 3936.1 3938.7 3959.7 7794.6 7810.6 7825.2 7829.9 7861.3 4217.5 4227.8 4234.2 4237.9 4245.4 3272.2 3393.7 3614.5 3851.4 3856.3 3108.7 3131.1 3222.7 3230.8 3258.4 981.2 982.4 1000.6 1004.4 1015.5 612.4 724.9 736.9 740.3 749.4 4560.4 4623.0 4634.6 4712.5 4799.0 365.2 369.8 370.7 373.9 376.4 3106.0 3180.8 3183.1 3208.8 3222.5 8490.9 8837.6 8863.6 8936.3 8940.3 8840.0 8873.7 8877.3 8942.2 8943.3 6854.8 6884.4 6943.3 6953.6 6960.9 4730.6 4779.8 4792.4 4826.8 4830.2 7936.4 7942.1 8000.8 8048.1 8115.4 7956.7 8071.7 8141.6 8148.3 8176.7 5451.4 5902.8 6109.4 6147.8 6265.5 6274.3 6565.9 6838.6 6861.7 6985.8 6262.7 6291.4 6349.0 6371.4 6484.1 6141.2 6207.7 6208.8 6219.8 6304.7 5643.7 5664.9 5740.1 5747.1 5798.4 4241.9 4339.4 4384.7 4460.0 4628.4 4364.4 4394.9 4427.0 4429.6 4530.0 09:23:22 INFO - PROCESS | 27350 | 09:23:22 INFO - PROCESS | 27350 | [#4] prototype.html Cycles:180 Average:4349.85 Median:5022.85 stddev:1300.73 (25.9%) stddev-sans-first:1268.04 09:23:22 INFO - PROCESS | 27350 | Values: 282.1 283.8 284.2 285.1 289.4 5058.7 5124.9 5132.2 5143.6 5148.9 4963.9 4995.0 5022.9 5038.7 5047.6 3639.4 3760.2 3769.0 3854.6 3881.2 3874.7 3889.1 3894.8 3899.6 3908.2 3864.0 3886.2 3889.0 3895.8 3906.5 3819.8 3834.1 3845.4 3910.4 3931.9 3377.9 3384.8 3385.4 3389.6 3391.3 4847.6 4889.6 4908.6 4923.5 4926.1 4403.7 4477.2 4481.0 4485.1 4486.6 4953.4 5274.8 5275.6 5311.4 5316.1 3658.5 3659.7 3662.5 3666.8 3668.9 5480.7 5491.2 5540.4 5551.6 5566.6 3569.6 3652.4 3652.7 3667.6 3673.4 3706.1 3722.2 3729.9 3736.0 3743.3 4335.7 4349.3 4352.3 4358.6 4371.4 5153.9 5206.6 5263.0 5268.4 5325.6 1276.6 1286.9 1288.0 1289.2 1289.5 780.5 813.2 813.5 814.1 816.6 4421.9 4486.6 4552.6 4605.9 4625.9 5420.2 5464.5 5470.6 5473.8 5474.9 4610.9 4626.2 4631.5 4632.0 4634.7 2706.5 2896.4 2900.0 2904.7 2907.6 5054.2 5055.8 5062.5 5069.7 5083.5 5337.3 5524.9 5560.8 5567.3 5569.4 5013.4 5022.5 5022.8 5031.3 5041.1 5443.4 5444.9 5460.4 5463.2 5495.3 5097.3 5320.0 5343.4 5345.2 5361.9 5065.5 5069.2 5094.1 5126.6 5127.6 3721.6 3742.8 3748.1 3749.9 3757.2 5217.8 5485.5 5487.0 5487.2 5511.0 5333.1 5337.3 5378.5 5379.9 5399.1 5325.7 5333.4 5386.8 5393.7 5403.1 5115.8 5204.9 5215.5 5253.5 5262.6 5044.8 5186.3 5197.4 5336.6 5373.5 5181.7 5190.4 5218.5 5236.7 5255.8 09:23:22 INFO - PROCESS | 27350 | 09:23:22 INFO - PROCESS | 27350 | [#5] yui.html Cycles:180 Average:17537.87 Median:495.40 stddev:25714.56 (5190.7%) stddev-sans-first:25755.02 09:23:22 INFO - PROCESS | 27350 | Values: 540.7 546.9 559.5 580.6 670.5 10779.6 11656.6 11712.9 11720.1 11786.4 11488.8 11642.0 11643.6 11648.1 11657.4 730.0 749.0 752.3 753.8 757.5 723.4 747.2 753.5 756.5 760.8 806.6 811.4 811.4 811.6 811.6 796.8 799.1 800.5 804.0 804.0 595.1 597.0 597.0 597.9 598.3 12364.4 12464.2 12471.9 12477.4 12493.8 12583.2 12650.9 13039.5 13047.3 13838.2 9882.0 9964.5 9986.1 10123.2 10376.4 3216.1 3218.0 3228.5 3260.4 3288.3 61854.4 62000.4 62945.7 63111.7 64035.0 10006.7 10071.6 10180.1 10245.9 10428.1 16005.5 16472.0 16501.5 18575.2 18625.0 6200.2 6528.6 6576.0 6590.5 6607.7 3368.2 3372.3 3384.0 3405.5 3548.2 2733.6 2832.5 2842.9 2844.6 2845.9 475.3 481.4 485.8 486.7 497.5 450.3 484.7 498.5 498.6 518.5 7418.0 7466.0 7518.4 7540.4 7754.5 469.7 493.3 504.0 506.3 511.1 3535.3 3572.7 3732.6 3746.2 3854.6 55605.2 98558.0 100047.0 108678.0 109336.0 85873.0 86556.6 87185.0 90645.5 91433.5 60067.0 75089.6 77502.6 79000.6 79187.0 7091.5 7295.6 7502.7 7519.4 7560.0 45753.5 46142.5 47036.5 47215.5 47361.5 50412.5 58257.4 59567.0 67891.3 69304.3 9834.5 9920.0 10088.2 10980.3 11119.9 12460.4 12496.6 12501.9 12644.2 12842.3 11307.0 11433.1 11712.1 11969.1 12757.8 11710.9 11765.7 11821.6 11984.7 12387.2 10858.5 11578.1 11617.4 11878.8 12126.6 9033.6 9678.5 9874.2 9894.5 9914.6 8802.3 8838.4 9276.8 9761.3 9895.7 09:23:22 INFO - PROCESS | 27350 | -------- Summary: end -------- 09:23:22 INFO - PROCESS | 27350 | 09:23:23 INFO - TEST-INFO | 27350: exit 0 09:23:24 INFO - TEST-OK | dromaeo_css | took 1120154ms 09:23:24 INFO - TEST-START | kraken 09:23:24 INFO - operating with platform_type : linux_ 09:23:24 INFO - Initialising browser for kraken test... 09:23:24 INFO - TEST-INFO | started process 27711 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptjFH6I/profile http://localhost:40648/getInfo.html) 09:23:28 INFO - PROCESS | 27711 | __metrics Screen width/height:1600/1200 09:23:28 INFO - PROCESS | 27711 | colorDepth:24 09:23:28 INFO - PROCESS | 27711 | Browser inner width/height: 1024/697 09:23:28 INFO - PROCESS | 27711 | __metrics 09:23:29 ERROR - PROCESS | 27711 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 09:23:30 INFO - TEST-INFO | 27711: exit 0 09:23:30 INFO - Browser initialized. 09:23:30 INFO - Running cycle 1/1 for kraken test... 09:23:30 INFO - TEST-INFO | started process 27832 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptjFH6I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:23:42 INFO - PROCESS | 27832 | RSS: Main: 186302464 09:23:42 INFO - PROCESS | 27832 | 09:23:45 INFO - PROCESS | 27832 | Cycle 1(1): loaded http://localhost:40648/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40648/tests/kraken/driver.html?testName=audio-beat-detection) 09:23:46 INFO - PROCESS | 27832 | RSS: Main: 200306688 09:23:46 INFO - PROCESS | 27832 | 09:23:49 INFO - PROCESS | 27832 | Cycle 1(1): loaded http://localhost:40648/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40648/tests/kraken/driver.html?testName=audio-dft) 09:23:49 INFO - PROCESS | 27832 | RSS: Main: 198012928 09:23:49 INFO - PROCESS | 27832 | 09:23:52 INFO - PROCESS | 27832 | Cycle 1(1): loaded http://localhost:40648/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40648/tests/kraken/driver.html?testName=audio-fft) 09:23:53 INFO - PROCESS | 27832 | RSS: Main: 193794048 09:23:53 INFO - PROCESS | 27832 | 09:23:55 INFO - PROCESS | 27832 | Cycle 1(1): loaded http://localhost:40648/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40648/tests/kraken/driver.html?testName=audio-oscillator) 09:23:56 INFO - PROCESS | 27832 | RSS: Main: 194785280 09:23:56 INFO - PROCESS | 27832 | 09:23:58 INFO - PROCESS | 27832 | Cycle 1(1): loaded http://localhost:40648/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40648/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:23:58 INFO - PROCESS | 27832 | RSS: Main: 195133440 09:23:58 INFO - PROCESS | 27832 | 09:24:02 INFO - PROCESS | 27832 | Cycle 1(1): loaded http://localhost:40648/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40648/tests/kraken/driver.html?testName=imaging-darkroom) 09:24:02 INFO - PROCESS | 27832 | RSS: Main: 194469888 09:24:02 INFO - PROCESS | 27832 | 09:24:06 INFO - PROCESS | 27832 | Cycle 1(1): loaded http://localhost:40648/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40648/tests/kraken/driver.html?testName=imaging-desaturate) 09:24:06 INFO - PROCESS | 27832 | RSS: Main: 193118208 09:24:06 INFO - PROCESS | 27832 | 09:24:09 INFO - PROCESS | 27832 | Cycle 1(1): loaded http://localhost:40648/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40648/tests/kraken/driver.html?testName=json-parse-financial) 09:24:10 INFO - PROCESS | 27832 | RSS: Main: 194076672 09:24:10 INFO - PROCESS | 27832 | 09:24:12 INFO - PROCESS | 27832 | Cycle 1(1): loaded http://localhost:40648/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40648/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:24:12 INFO - PROCESS | 27832 | RSS: Main: 194285568 09:24:12 INFO - PROCESS | 27832 | 09:24:14 INFO - PROCESS | 27832 | Cycle 1(1): loaded http://localhost:40648/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40648/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:24:15 INFO - PROCESS | 27832 | RSS: Main: 194703360 09:24:15 INFO - PROCESS | 27832 | 09:24:17 INFO - PROCESS | 27832 | Cycle 1(1): loaded http://localhost:40648/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40648/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:24:18 INFO - PROCESS | 27832 | RSS: Main: 194351104 09:24:18 INFO - PROCESS | 27832 | 09:24:21 INFO - PROCESS | 27832 | Cycle 1(1): loaded http://localhost:40648/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40648/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:24:21 INFO - PROCESS | 27832 | RSS: Main: 194473984 09:24:21 INFO - PROCESS | 27832 | 09:24:24 INFO - PROCESS | 27832 | Cycle 1(1): loaded http://localhost:40648/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40648/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:24:25 INFO - PROCESS | 27832 | RSS: Main: 195026944 09:24:25 INFO - PROCESS | 27832 | 09:24:27 INFO - PROCESS | 27832 | Cycle 1(1): loaded http://localhost:40648/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40648/tests/kraken/driver.html?testName=ai-astar) 09:24:27 INFO - PROCESS | 27832 | RSS: Main: 195850240 09:24:27 INFO - PROCESS | 27832 | 09:24:27 INFO - PROCESS | 27832 | __start_tp_report 09:24:27 INFO - PROCESS | 27832 | _x_x_mozilla_page_load 09:24:27 INFO - PROCESS | 27832 | _x_x_mozilla_page_load_details 09:24:27 INFO - PROCESS | 27832 | |i|pagename|runs| 09:24:27 INFO - PROCESS | 27832 | |0;ai-astar;115;114;115;114;115;115;114;115;114;115 09:24:27 INFO - PROCESS | 27832 | |1;audio-beat-detection;160;128;131;186;131;137;129;131;160;138 09:24:27 INFO - PROCESS | 27832 | |2;audio-dft;162;184;167;166;163;163;163;164;163;164 09:24:27 INFO - PROCESS | 27832 | |3;audio-fft;77;78;76;117;77;77;77;76;105;77 09:24:27 INFO - PROCESS | 27832 | |4;audio-oscillator;84;83;120;83;83;84;107;84;84;109 09:24:27 INFO - PROCESS | 27832 | |5;imaging-gaussian-blur;118;117;118;118;117;126;119;118;119;118 09:24:27 INFO - PROCESS | 27832 | |6;imaging-darkroom;149;149;148;147;147;148;147;147;149;148 09:24:27 INFO - PROCESS | 27832 | |7;imaging-desaturate;95;96;96;95;95;97;97;97;96;95 09:24:27 INFO - PROCESS | 27832 | |8;json-parse-financial;66;63;67;65;67;67;66;65;67;65 09:24:27 INFO - PROCESS | 27832 | |9;json-stringify-tinderbox;65;66;65;66;69;65;67;67;67;66 09:24:27 INFO - PROCESS | 27832 | |10;stanford-crypto-aes;87;85;86;84;85;85;85;87;86;84 09:24:27 INFO - PROCESS | 27832 | |11;stanford-crypto-ccm;145;145;143;141;142;144;149;142;182;143 09:24:27 INFO - PROCESS | 27832 | |12;stanford-crypto-pbkdf2;177;177;177;179;184;179;182;182;173;176 09:24:27 INFO - PROCESS | 27832 | |13;stanford-crypto-sha256-iterative;74;71;71;71;73;72;70;73;70;70 09:24:27 INFO - PROCESS | 27832 | __end_tp_report 09:24:27 INFO - PROCESS | 27832 | __start_cc_report 09:24:27 INFO - PROCESS | 27832 | _x_x_mozilla_cycle_collect,843 09:24:27 INFO - PROCESS | 27832 | __end_cc_report 09:24:27 INFO - PROCESS | 27832 | __startTimestamp1475771067531__endTimestamp 09:24:27 INFO - PROCESS | 27832 | 09:24:27 INFO - PROCESS | 27832 | ------- Summary: start ------- 09:24:27 INFO - PROCESS | 27832 | Number of tests: 14 09:24:27 INFO - PROCESS | 27832 | 09:24:27 INFO - PROCESS | 27832 | [#0] ai-astar Cycles:10 Average:114.60 Median:115.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 09:24:27 INFO - PROCESS | 27832 | Values: 115.0 114.0 115.0 114.0 115.0 115.0 114.0 115.0 114.0 115.0 09:24:27 INFO - PROCESS | 27832 | 09:24:27 INFO - PROCESS | 27832 | [#1] audio-beat-detection Cycles:10 Average:143.10 Median:137.50 stddev:19.27 (14.0%) stddev-sans-first:19.44 09:24:27 INFO - PROCESS | 27832 | Values: 160.0 128.0 131.0 186.0 131.0 137.0 129.0 131.0 160.0 138.0 09:24:27 INFO - PROCESS | 27832 | 09:24:27 INFO - PROCESS | 27832 | [#2] audio-dft Cycles:10 Average:165.90 Median:164.00 stddev:6.54 (4.0%) stddev-sans-first:6.78 09:24:27 INFO - PROCESS | 27832 | Values: 162.0 184.0 167.0 166.0 163.0 163.0 163.0 164.0 163.0 164.0 09:24:27 INFO - PROCESS | 27832 | 09:24:27 INFO - PROCESS | 27832 | [#3] audio-fft Cycles:10 Average:83.70 Median:77.00 stddev:14.67 (19.1%) stddev-sans-first:15.36 09:24:27 INFO - PROCESS | 27832 | Values: 77.0 78.0 76.0 117.0 77.0 77.0 77.0 76.0 105.0 77.0 09:24:27 INFO - PROCESS | 27832 | 09:24:27 INFO - PROCESS | 27832 | [#4] audio-oscillator Cycles:10 Average:92.10 Median:83.50 stddev:14.13 (16.9%) stddev-sans-first:14.68 09:24:27 INFO - PROCESS | 27832 | Values: 84.0 83.0 120.0 83.0 83.0 84.0 107.0 84.0 84.0 109.0 09:24:27 INFO - PROCESS | 27832 | 09:24:27 INFO - PROCESS | 27832 | [#5] imaging-gaussian-blur Cycles:10 Average:118.80 Median:118.00 stddev:2.62 (2.2%) stddev-sans-first:2.76 09:24:27 INFO - PROCESS | 27832 | Values: 118.0 117.0 118.0 118.0 117.0 126.0 119.0 118.0 119.0 118.0 09:24:27 INFO - PROCESS | 27832 | 09:24:27 INFO - PROCESS | 27832 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.88 (0.6%) stddev-sans-first:0.83 09:24:27 INFO - PROCESS | 27832 | Values: 149.0 149.0 148.0 147.0 147.0 148.0 147.0 147.0 149.0 148.0 09:24:27 INFO - PROCESS | 27832 | 09:24:27 INFO - PROCESS | 27832 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.88 (0.9%) stddev-sans-first:0.87 09:24:27 INFO - PROCESS | 27832 | Values: 95.0 96.0 96.0 95.0 95.0 97.0 97.0 97.0 96.0 95.0 09:24:27 INFO - PROCESS | 27832 | 09:24:27 INFO - PROCESS | 27832 | [#8] json-parse-financial Cycles:10 Average:65.80 Median:66.50 stddev:1.32 (2.0%) stddev-sans-first:1.39 09:24:27 INFO - PROCESS | 27832 | Values: 66.0 63.0 67.0 65.0 67.0 67.0 66.0 65.0 67.0 65.0 09:24:27 INFO - PROCESS | 27832 | 09:24:27 INFO - PROCESS | 27832 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.50 stddev:1.25 (1.9%) stddev-sans-first:1.24 09:24:27 INFO - PROCESS | 27832 | Values: 65.0 66.0 65.0 66.0 69.0 65.0 67.0 67.0 67.0 66.0 09:24:27 INFO - PROCESS | 27832 | 09:24:27 INFO - PROCESS | 27832 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:85.50 stddev:1.07 (1.3%) stddev-sans-first:0.97 09:24:27 INFO - PROCESS | 27832 | Values: 87.0 85.0 86.0 84.0 85.0 85.0 85.0 87.0 86.0 84.0 09:24:27 INFO - PROCESS | 27832 | 09:24:27 INFO - PROCESS | 27832 | [#11] stanford-crypto-ccm Cycles:10 Average:147.60 Median:144.50 stddev:12.29 (8.5%) stddev-sans-first:13.00 09:24:27 INFO - PROCESS | 27832 | Values: 145.0 145.0 143.0 141.0 142.0 144.0 149.0 142.0 182.0 143.0 09:24:27 INFO - PROCESS | 27832 | 09:24:27 INFO - PROCESS | 27832 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.60 Median:179.00 stddev:3.31 (1.8%) stddev-sans-first:3.46 09:24:27 INFO - PROCESS | 27832 | Values: 177.0 177.0 177.0 179.0 184.0 179.0 182.0 182.0 173.0 176.0 09:24:27 INFO - PROCESS | 27832 | 09:24:27 INFO - PROCESS | 27832 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:71.50 stddev:1.43 (2.0%) stddev-sans-first:1.20 09:24:27 INFO - PROCESS | 27832 | Values: 74.0 71.0 71.0 71.0 73.0 72.0 70.0 73.0 70.0 70.0 09:24:27 INFO - PROCESS | 27832 | -------- Summary: end -------- 09:24:27 INFO - PROCESS | 27832 | 09:24:28 INFO - TEST-INFO | 27832: exit 0 09:24:28 INFO - TEST-OK | kraken | took 64763ms 09:24:28 INFO - SUITE-END | took 1184s 09:24:29 INFO - Completed test suite (00:19:45) 09:24:29 INFO - javascript benchmark 09:24:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6163.203918565583, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2617.057859170698, 2629.2112366290107, 2636.525425423424, 2653.8938442462304, 2656.827306225096, 4603.0, 4751.216049351857, 4752.144613969488, 4776.928346074807, 4812.302216178652, 4671.509491503394, 4780.139574876521, 4809.591184749301, 4827.46897841238, 4835.734034628094, 4366.432363792718, 4414.095110502355, 4452.97773511132, 4491.056878055612, 4560.8403705870305, 4431.1802316571375, 4460.353248778925, 4471.374007638933, 4494.943688233279, 4500.392447019643, 4292.506361768405, 4332.350147477872, 4381.298992161239, 4419.359192917042, 4462.241418958753, 4405.933910991338, 4423.911521769546, 4449.26587113126, 4468.8882777930485, 4480.641548676098, 4386.7367957922625, 4404.823807047715, 4420.07178492517, 4426.756528390937, 4473.664475164375, 4663.0, 4690.742009189493, 4757.1437141314545, 4810.975945120252, 4850.393700787402, 5117.820876269313, 5163.5352818246165, 5163.5352818246165, 5234.16253399458, 5236.6857988520815, 5178.508041736029, 5195.2986346843445, 5204.9479505204845, 5207.817726379559, 5253.711045892474, 4726.432828060655, 4785.258284965836, 4836.226203807374, 4837.540433658797, 4844.370231869834, 5183.792648294026, 5211.5830733541225, 5217.478252174752, 5237.947620523746, 5302.522772950376, 5021.297018417425, 5025.748712564357, 5026.29631851541, 5027.798888044437, 5093.490650934951, 4950.851474455772, 5028.949710502921, 5100.515451032146, 5127.1540195867265, 5177.58579313654, 5135.7432128394175, 5150.27896094547, 5150.974245128826, 5191.636585438983, 5201.661891977009, 5104.846854594368, 5112.769925353294, 5128.230765385148, 5138.332016837787, 5182.870428239325, 4271.31658934569, 4322.654187664979, 4328.43730315057, 4406.7576283304725, 4478.596926276651, 3788.4885540452237, 3815.6565909068318, 3849.2301539692176, 3850.0759817643566, 3857.286402015636, 4357.477102747627, 4376.540463251376, 4404.163208990281, 4408.360787685768, 4440.4005459263235, 5107.719075450812, 5127.359080114986, 5132.974335128375, 5172.120739474299, 5193.324867767166, 4280.165367753259, 4397.1865204937185, 4400.22995975703, 4406.7576283304725, 4444.044530425974, 4524.502304746476, 4547.090581883636, 4566.840160594364, 4567.314902764612, 4646.767661616906, 4700.95299047012, 4731.006488637425, 4740.265258884879, 4745.715257084586, 4793.257045158006, 5090.669106508065, 5097.745112744422, 5098.847034588968, 5104.1067813133295, 5109.718965456936, 4646.814127435, 4668.276417155346, 4669.7431641260055, 4696.600788932979, 4707.129181101507, 4974.37820272466, 4975.726335051462, 4976.154053810788, 4978.0, 5037.420696619935, 5007.974960125322, 5009.148444764326, 5017.071841709296, 5019.799208031638, 5080.923786143137, 4804.6876952997945, 4834.927476087792, 4902.534259245366, 4918.532739389752, 4967.82612608557, 4935.901281974412, 4939.901201975868, 4968.3292755479, 5000.199968005247, 5019.447860735389, 4797.95202047989, 4886.609071274361, 4906.6320025997475, 4910.533499317559, 4930.408350997904, 4884.755762211947, 4974.353334066548, 4990.850274491771, 4991.725455100004, 5010.949890501049, 4780.091782561302, 4811.615070794258, 4835.564799168092, 4890.926636100533, 4894.363732714724], "value": 4687.225104598697, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.2639047699888, 551.010935371009, 561.1414535760288, 566.1196838915486, 580.2688612348439, 37037.44443833345, 39050.21899562007, 39131.413028804556, 41894.0, 41952.16095678085, 39171.0, 39706.0, 39717.60282397175, 39733.20533589327, 39742.602573974254, 7475.514091584043, 7645.808854778619, 7673.577953212571, 7673.846523069536, 7731.22687731228, 7639.3124618784295, 7713.498622589514, 7720.80327549228, 7727.497712648688, 7733.613319334039, 7705.537667739954, 7710.498817576868, 7733.8066548336465, 7740.729074482394, 7741.380689544823, 7509.9624501877415, 7526.322630963185, 7542.6605802739, 7545.773626791205, 7547.169811320723, 7653.311201991847, 7714.151443341228, 7721.459497835153, 7723.806904827368, 7749.9225007749765, 36394.45408318877, 36596.0850978725, 36691.266174676624, 36772.44841327382, 36797.63202367996, 2560.590305551103, 2623.6720409948757, 2651.1287698225033, 2655.6016597510334, 2773.362126710868, 27052.59421108685, 27220.638968051717, 27338.726612733815, 27355.316117097034, 27708.168754937386, 3043.3508643851364, 3141.2618034761813, 3154.921126971821, 3156.6054243219596, 3178.8410579471165, 230068.0, 231064.9999999983, 231142.0, 231245.0, 231282.0, 47335.76332118317, 47807.282890756665, 47817.521824782, 47890.28164577534, 47939.0, 49228.26157607639, 49331.50668493341, 49735.502644973814, 49933.0, 49950.50049499459, 11783.528658853722, 11846.407679615984, 11977.700557486132, 12045.819312710317, 12050.09624278165, 7893.684252629945, 7916.287534121957, 7948.721794737156, 7967.56178410193, 8034.799130021796, 13036.934815326053, 14029.579112626638, 14114.788278175836, 14178.220197889008, 14370.209638469776, 5731.312242530923, 5746.5977381583725, 5749.453801888814, 5763.3200561738995, 5965.9105113422465, 771.8494893495827, 847.9745607631781, 887.3655336434481, 904.3669431398048, 948.4498990585444, 26561.734382656312, 26933.595996060074, 27107.728922710914, 27297.590536141975, 27631.861840690668, 904.5251243097294, 960.3661583355092, 964.3394274921701, 983.2822039910905, 1002.4135880509838, 13823.170609763447, 13911.721765564633, 14013.859861401255, 14189.716205675828, 14237.0, 358869.0, 362040.0, 362731.0, 363246.0, 363654.0, 44907.32639010417, 45212.3218151728, 45380.0, 45397.319040214425, 45434.0, 1140.1619809440056, 1162.587281515067, 1173.524722487394, 1180.4628893853276, 1182.9053675705923, 23710.52578948377, 24372.5782414307, 25372.873135634203, 25650.743492565583, 25694.357641059123, 38315.808420957714, 38700.2259954805, 38743.2251354977, 38848.41727374035, 39002.804985974886, 265453.0, 265676.0, 265809.0, 314425.0, 314567.0, 22728.772712272665, 22921.426964326027, 23222.535549289256, 23230.070797167926, 23299.0, 38422.423663645626, 38480.422793658676, 39085.41371879481, 39106.41340379953, 39113.608863910995, 33233.927940217596, 33434.33131337408, 33630.159246019044, 33803.83098084494, 34098.0, 32872.671273286964, 32978.505322420664, 32978.83510582432, 33373.16567085745, 33676.831615841766, 27911.720882791724, 28443.146705598865, 32535.674643253264, 33468.49797253092, 33508.0, 25522.489550209262, 29608.407831843673, 30674.625791162507, 30704.846475767477, 30946.84526577353, 24235.39411514726, 24546.802982489353, 24588.557601935387, 24785.50428991374, 24821.50356992886], "value": 16151.134632572865, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.63475129484493, 350.3431066749844, 350.97192224622034, 354.83854846045045, 371.0371585735018, 15383.69232615347, 15790.052596844183, 16620.168991550403, 16747.246373913174, 16764.748528772077, 14885.702285954274, 15198.54404367868, 15350.0, 15491.0, 16011.35954561819, 4586.334981427691, 4599.2752717730855, 4681.485036645966, 4699.154152252593, 4741.336212930192, 4571.131485017836, 4660.137874493213, 4663.626909847204, 4665.300204969248, 4670.719756814585, 4566.474855391622, 4666.743329116897, 4692.601128904047, 5124.359455068116, 5180.041692286939, 5111.51440613143, 5161.045206636765, 5164.0, 5169.56058735008, 5179.326687530634, 4491.573300536444, 4623.86128416148, 4646.953530464686, 4655.6973796703105, 4667.369905062807, 18862.905685471622, 19046.80953190464, 19354.225830966745, 19977.400677979684, 20373.796262037336, 1743.5902562897709, 1867.0851282871295, 1909.9045047747557, 1941.7378653881685, 2033.4916270932267, 8539.786505337353, 8873.157050080232, 8983.865242021375, 9045.185933265971, 9378.0, 1702.5403141151944, 1723.4571110100278, 1749.658816530777, 1756.1482680899753, 1782.6880295948158, 64787.67606161986, 67950.980735289, 68472.31527684709, 69786.0, 69979.65010174917, 9810.362326448758, 9857.40855548655, 9859.161971232526, 10007.699769006942, 10167.542460589291, 13595.456181752817, 13601.183928964096, 13602.115862468909, 13608.93195534016, 13645.181289122684, 6421.3578642136345, 6498.772542960974, 6586.8353291168105, 6624.105745724362, 6769.966150169218, 5604.243427137284, 5839.065749480063, 5903.203067585821, 5956.434138756811, 6145.600535965148, 4048.8785336439955, 4098.672106231495, 4129.545749967501, 4147.564505726916, 4247.617714405656, 1777.8044415114327, 1820.1627251464474, 1841.5580260737327, 1874.0910658330972, 1893.365722482956, 810.9878351824727, 816.8243827577099, 861.6553378648591, 876.548577482597, 879.4767113567417, 16160.595985100466, 17162.914185428992, 17177.398791042255, 17433.21550530229, 17685.292588296325, 815.995920020396, 839.1817977471916, 845.9619317130744, 862.1421685423044, 878.5124256037833, 9248.861267081, 9679.177269931994, 9840.3603765755, 9842.60629574809, 9990.350627209207, 336493.0, 350384.0, 350397.0, 350727.0, 351087.0, 83184.58407707923, 84052.0, 84072.57963710265, 85175.574122129, 86307.0, 890.888638920135, 908.0828363352929, 936.6908920056366, 941.7127776028377, 944.1078181118777, 15578.454754083552, 15677.921610391875, 15913.363465461252, 16197.51407457778, 16230.269637866088, 27429.58855617207, 36233.81883090568, 37168.25663486769, 37280.44079338866, 37958.430623540116, 51639.74180129075, 51859.74070129625, 51939.220911685596, 52423.0, 52640.47359526356, 7428.7585331005175, 7668.57822819728, 7707.499012564165, 7771.8834217485655, 7834.960825195838, 11399.259048161843, 11946.581869634521, 11987.40062996864, 12092.516299347928, 12832.101752877208, 9704.660336888175, 9981.301308908307, 10065.144462720751, 10090.8486372703, 10384.636537721144, 10026.749331266778, 10033.347832390871, 10182.592696292066, 10357.741056473347, 10535.525901334611, 9740.464274464972, 9975.3017288792, 10063.798724025331, 10227.642032528825, 10473.057424831803, 7390.334869861738, 7579.583122928292, 7614.9719787827935, 7644.426667999811, 7766.728164514215, 9055.411398259092, 10089.848652270075, 10359.689209323733, 10384.636537721144, 10408.271421000458], "value": 7937.494500762246, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1350.0684527675903, 1359.109783092075, 1377.7313423882345, 1413.6253892718437, 1420.9218492982889, 6634.402903738663, 6866.828329291758, 6910.17077950646, 7486.513376630522, 7510.098788145423, 6730.0, 6898.689558969846, 6926.653667316639, 7132.714691412337, 7151.678174482147, 2110.229766135361, 2123.203798575534, 2140.860844045132, 2141.4004078857943, 2142.657174852024, 2011.0045527463926, 2021.2117274263048, 2034.5829105033433, 2059.2483743433613, 2093.7278153840057, 2083.312506872736, 2101.086027578001, 2111.9472013199716, 2124.1184908263053, 2131.8187954023847, 1995.5809280051208, 1997.6603977323816, 2004.859659823813, 2011.3965810257012, 2015.1838505405187, 1996.790337014607, 2024.038581673708, 2047.119738512439, 2047.392796654619, 2056.5886822635534, 7378.557286562824, 7395.889061664079, 7401.814954626124, 7430.182679905206, 7443.404527637776, 4084.6732261419015, 4197.370394440828, 4206.642435392995, 4207.158568286324, 4209.2423363794505, 2632.565626671597, 2719.9120351859215, 2741.6984131745494, 2745.149003808806, 2776.278167676419, 814.4665244265016, 814.5072231300037, 822.5311572403732, 828.7555171224443, 828.9626966786449, 9780.755481112958, 9825.164860986753, 9826.90173098267, 9930.404175749478, 10025.298229124037, 3723.255348930171, 3764.698824094066, 3936.1340505088833, 3938.6849052076336, 3959.742616729903, 7794.571298578632, 7810.609469526615, 7825.217478252129, 7829.882551761728, 7861.2531809478005, 4217.472815898012, 4227.767472788964, 4234.153169366139, 4237.87286381409, 4245.426867372927, 3272.2310257089566, 3393.6606339365867, 3614.475900994341, 3851.422286657024, 3856.267309211297, 3108.704673056056, 3131.091983324856, 3222.7421806255443, 3230.8384580770867, 3258.4460641690494, 981.190517822799, 982.4498280962683, 1000.6297669862198, 1004.4073996342194, 1015.4770293298957, 612.4487960835284, 724.8535398669405, 736.9005184300158, 740.2523451314104, 749.4192001199115, 4560.4071470708595, 4622.953770462253, 4634.559716826896, 4712.528747125329, 4798.95201047992, 365.1710616899623, 369.81878879348926, 370.70899344014816, 373.8616711816645, 376.38836890053665, 3105.9534106988413, 3180.80915145092, 3183.108729555728, 3208.7753857230236, 3222.468292731673, 8490.915090849012, 8837.60230789616, 8863.64545418189, 8936.32977526688, 8940.32947528938, 8839.955800220958, 8873.689420870238, 8877.289816814638, 8942.195202431813, 8943.329250306253, 6854.828629284308, 6884.380405763405, 6943.305669433016, 6953.582785032813, 6960.9303906961295, 4730.596695743878, 4779.832705855418, 4792.424909010941, 4826.758662066813, 4830.203016502238, 7936.444448888522, 7942.086660033939, 8000.759977200693, 8048.114707382067, 8115.431919765796, 7956.681732730626, 8071.677132914618, 8141.552214628252, 8148.266656000988, 8176.713815016446, 5451.400345961862, 5902.822915312548, 6109.389061093855, 6147.815565533041, 6265.467435268053, 6274.341194174728, 6565.934340656532, 6838.555493892881, 6861.725530978904, 6985.755498557729, 6262.718177681924, 6291.370862913672, 6348.968255158879, 6371.362863713592, 6484.059811327425, 6141.232345956755, 6207.689615519296, 6208.751649934133, 6219.782307619212, 6304.653244071436, 5643.746031428677, 5664.943350566442, 5740.0815869460685, 5747.109198074138, 5798.376454592552, 4241.91516169681, 4339.435873336446, 4384.714993525411, 4460.041091165415, 4628.35203071577, 4364.432623758891, 4394.890127746832, 4426.9778651106535, 4429.557044295545, 4530.0], "value": 3705.86675496285, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.12822378849353, 283.77865265093226, 284.2424937541452, 285.1459877666388, 289.43704494757696, 5058.671186372888, 5124.9487505124935, 5132.153194722866, 5143.562797162241, 5148.871278218046, 4963.900721985558, 4995.0, 5022.899542009158, 5038.748062596874, 5047.621428392867, 3639.363111455498, 3760.247950409915, 3768.9811550942345, 3854.614538546137, 3881.2237552489473, 3874.728768986172, 3889.124946886956, 3894.7731464588705, 3899.551551571563, 3908.17928235071, 3863.98068009661, 3886.24218277436, 3889.0, 3895.7857317847506, 3906.4921560197276, 3819.8472061117523, 3834.1373191032076, 3845.4231865220163, 3910.432987216866, 3931.862384816532, 3377.8986630401128, 3384.76306658534, 3385.3567822113964, 3389.57630296213, 3391.287829555796, 4847.636427267934, 4889.608831293488, 4908.631852611068, 4923.532264434873, 4926.11329960607, 4403.735775853427, 4477.238869392211, 4480.955190448119, 4485.093835120061, 4486.641068714495, 4953.4303555091265, 5274.760431298641, 5275.551578115865, 5311.442298558673, 5316.149416093406, 3658.506101676266, 3659.743817932746, 3662.531711312195, 3666.7616604920863, 3668.926621467556, 5480.698561579152, 5491.203775452577, 5540.418256083134, 5551.557314781483, 5566.610337276392, 3569.625189355132, 3652.392947103266, 3652.726045546595, 3667.5598928128798, 3673.430618254175, 3706.1475860552223, 3722.218334149859, 3729.9254014920093, 3735.9626403736156, 3743.2513497300647, 4335.653147748172, 4349.26062569364, 4352.325389564622, 4358.607725304674, 4371.431713877176, 5153.922691159635, 5206.609504287194, 5263.0, 5268.446813084647, 5325.627206095536, 1276.6042526816716, 1286.8713128687057, 1287.9678008049873, 1289.1878116786365, 1289.4777615065914, 780.4926797581504, 813.2396209543977, 813.5200231863229, 814.1166833985193, 816.6161903905155, 4421.943796134813, 4486.573775491323, 4552.590266875931, 4605.907881842411, 4625.861224163214, 5420.24116623673, 5464.480874316933, 5470.64440811346, 5473.808416705396, 5474.91787623186, 4610.884727881829, 4626.21354369758, 4631.467381251199, 4632.0, 4634.745089020136, 2706.526357887362, 2896.3628001839984, 2899.97100028997, 2904.7385735283924, 2907.578401131824, 5054.21659642756, 5055.848324550269, 5062.544371006554, 5069.721165335868, 5083.542481176712, 5337.306150200527, 5524.889502209933, 5560.833175004756, 5567.331920169606, 5569.407732012829, 5013.398392193033, 5022.4977502249485, 5022.799088036438, 5031.295618613397, 5041.092603331435, 5443.421407791696, 5444.923618155729, 5460.3993560707495, 5463.207834863843, 5495.313085864267, 5097.311862898461, 5320.0, 5343.438938911514, 5345.1714984177515, 5361.919571206357, 5065.518775716301, 5069.172774555334, 5094.140638666786, 5126.615503837153, 5127.6410651254055, 3721.5534135903863, 3742.812859357076, 3748.1191919898256, 3749.9250014999, 3757.2297678975197, 5217.791058499071, 5485.4788795064405, 5486.972565137149, 5487.204355368529, 5511.0, 5333.146696528537, 5337.279467272024, 5378.462153784591, 5379.946200538101, 5399.082156033405, 5325.653832500875, 5333.386660534088, 5386.8383948481605, 5393.703346315833, 5403.0544654686055, 5115.846524604268, 5204.921926171186, 5215.45237750046, 5253.50091741284, 5262.631915573959, 5044.772985215601, 5186.325777648882, 5197.4282828889545, 5336.626436149432, 5373.462653734751, 5181.715005674724, 5190.429052804264, 5218.530332269962, 5236.659617124875, 5255.818835183356], "value": 3921.8594275968317, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [540.7458494507582, 546.9097598896183, 559.490863314384, 580.550073692888, 670.5239280111123, 10779.622713205039, 11656.592019279327, 11712.941435292812, 11720.120990925694, 11786.351750653721, 11488.827667584972, 11642.0, 11643.592474263403, 11648.126390520703, 11657.358845263507, 729.9744508942175, 748.9700411983514, 752.2740555364072, 753.8454616803542, 757.5189754505873, 723.3995783499682, 747.237817426225, 753.4650398217273, 756.4553521464564, 760.8250102476434, 806.6329819931917, 811.37524106438, 811.4441607498852, 811.5942028985507, 811.6266517401973, 796.80079980005, 799.0890384961149, 800.5396896784372, 804.0311424733183, 804.0351578106296, 595.0627761276007, 596.9791057313016, 597.0387675841891, 597.9162917191596, 598.267122774602, 12364.44360003802, 12464.189827661263, 12471.875281247252, 12477.438515266835, 12493.75012499754, 12583.245005299712, 12650.873491265154, 13039.478420863154, 13047.282399468026, 13838.238896860668, 9882.0, 9964.451955142464, 9986.101250887383, 10123.240756943258, 10376.429296388771, 3216.083416226364, 3217.9517307240176, 3228.531862879869, 3260.3805276997296, 3288.2601414681744, 61854.381456185314, 62000.37999620036, 62945.68527157335, 63111.684441577956, 64035.0, 10006.69979900604, 10071.59713611462, 10180.134688551556, 10245.948770256102, 10428.113610343205, 16005.519834404986, 16472.023357197213, 16501.504954851374, 18575.16411761474, 18625.0, 6200.224971878515, 6528.575642583217, 6575.967120164369, 6590.47276217911, 6607.669616519155, 3368.1916340078205, 3372.274960883373, 3384.0, 3405.4551271796395, 3548.2371290172737, 2733.603627474005, 2832.5467925132293, 2842.9004984825433, 2844.5590933405356, 2845.857707114636, 475.25385145321513, 481.3670023918536, 485.7886819233645, 486.7444591589444, 497.534804957366, 450.32001677466604, 484.7333966318581, 498.5039885314063, 498.57122874328047, 518.4970578538812, 7417.9985701929545, 7465.962670186615, 7518.398528117737, 7540.434467414966, 7754.534727916343, 469.69235150976164, 493.26257245418327, 503.96724212926773, 506.34175571757305, 511.10046318479, 3535.275268569937, 3572.678458938708, 3732.5520937487677, 3746.1758413149064, 3854.6338097880657, 55605.165922511194, 98558.0, 100047.0, 108678.0, 109336.0, 85873.0, 86556.56721716477, 87185.0, 90645.54677226572, 91433.54283228674, 60067.0, 75089.62455187799, 77502.61248693833, 79000.6049969758, 79187.0, 7091.468139889425, 7295.635218238961, 7502.699892004259, 7519.43604229674, 7559.962200188964, 45753.54246457493, 46142.53857461383, 47036.52963470321, 47215.527844722485, 47361.52638473571, 50412.495875042245, 58257.4174258269, 59567.0, 67891.3210867885, 69304.30695692978, 9834.459104749307, 9920.0, 10088.243381746544, 10980.286281391684, 11119.944400277947, 12460.376981151088, 12496.625101246613, 12501.874981250072, 12644.178128421623, 12842.293673848028, 11307.0, 11433.142514311627, 11712.084982752964, 11969.102317326062, 12757.8086328707, 11710.882891170979, 11765.705857353634, 11821.645350639494, 11984.700382490508, 12387.19483233587, 10858.457077145953, 11578.073754099483, 11617.419129043345, 11878.762424751629, 12126.60544037447, 9033.593488293174, 9678.467684277432, 9874.160696340892, 9894.50527473609, 9914.603415863285, 8802.310954660776, 8838.381313308008, 9276.768080798034, 9761.335204430638, 9895.703128906145], "value": 6274.895908264686, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1577.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 115.0, 114.0, 115.0, 115.0, 114.0, 115.0, 114.0, 115.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 128.0, 131.0, 186.0, 131.0, 137.0, 129.0, 131.0, 160.0, 138.0], "value": 143.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 184.0, 167.0, 166.0, 163.0, 163.0, 163.0, 164.0, 163.0, 164.0], "value": 165.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 76.0, 117.0, 77.0, 77.0, 77.0, 76.0, 105.0, 77.0], "value": 83.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 120.0, 83.0, 83.0, 84.0, 107.0, 84.0, 84.0, 109.0], "value": 92.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 117.0, 126.0, 119.0, 118.0, 119.0, 118.0], "value": 118.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 148.0, 147.0, 147.0, 148.0, 147.0, 147.0, 149.0, 148.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 97.0, 97.0, 97.0, 96.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 67.0, 65.0, 67.0, 67.0, 66.0, 65.0, 67.0, 65.0], "value": 65.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 69.0, 65.0, 67.0, 67.0, 67.0, 66.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 86.0, 84.0, 85.0, 85.0, 85.0, 87.0, 86.0, 84.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 143.0, 141.0, 142.0, 144.0, 149.0, 142.0, 182.0, 143.0], "value": 147.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 177.0, 177.0, 179.0, 184.0, 179.0, 182.0, 182.0, 173.0, 176.0], "value": 178.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 71.0, 71.0, 71.0, 73.0, 72.0, 70.0, 73.0, 70.0, 70.0], "value": 71.5, "unit": "score"}]}]} 09:24:29 INFO - Return code: 0 09:24:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:24:29 ERROR - # TBPL SUCCESS # 09:24:29 INFO - Running post-action listener: _resource_record_post_action 09:24:29 INFO - [mozharness: 2016-10-06 16:24:29.329823Z] Finished run-tests step (success) 09:24:29 INFO - Running post-run listener: _resource_record_post_run 09:24:29 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 393822208; Read time: 12; Write time: 269468 09:24:29 INFO - TinderboxPrint: CPU usage
13.4% 09:24:29 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 09:24:29 INFO - TinderboxPrint: I/O write bytes / time
393,822,208 / 269,468 09:24:29 INFO - TinderboxPrint: CPU idle
8,303.2 (86.6%) 09:24:29 INFO - TinderboxPrint: CPU user
1,223.6 (12.8%) 09:24:29 INFO - TinderboxPrint: Swap in / out
0 / 0 09:24:29 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99131392; Read time: 0; Write time: 84232 09:24:29 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 293785600; Read time: 0; Write time: 185208 09:24:29 INFO - Running post-run listener: _upload_blobber_files 09:24:29 INFO - Blob upload gear active. 09:24:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:24:29 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 09:24:29 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:24:29 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:24:30 INFO - (blobuploader) - INFO - Open directory for files ... 09:24:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:24:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:24:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:24:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:24:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:24:31 INFO - (blobuploader) - INFO - Done attempting. 09:24:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:24:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:24:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:24:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:24:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:24:34 INFO - (blobuploader) - INFO - Done attempting. 09:24:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:24:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:24:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:24:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:24:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:24:35 INFO - (blobuploader) - INFO - Done attempting. 09:24:35 INFO - (blobuploader) - INFO - Iteration through files over. 09:24:35 INFO - Return code: 0 09:24:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:24:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:24:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/42c5ab2fad3459fc37cfd1e981c4e6c7f52af54bb80e65f45acbdbd0f6e88fb7e07809a922fa1412eec6fcc52dc01b9b6fc9b42161b29809185ec35721b91825", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f20965336aab473fbd768660e152b2f478e6d624255453c23b41d76304679520d2c242d4b7b33a114d5a8d49a4838f75e313a7be48072dbb61de043288cbc2b1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/fb306bf18ab3693f9e50a2f54be9205214fdf3a2b9d1ed9b92a82b50c1b78a0024feec1084af4bc654f578c431db18c4c74eb824d9d782cfa3a323360171fd32"} 09:24:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:24:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:24:35 INFO - Contents: 09:24:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/42c5ab2fad3459fc37cfd1e981c4e6c7f52af54bb80e65f45acbdbd0f6e88fb7e07809a922fa1412eec6fcc52dc01b9b6fc9b42161b29809185ec35721b91825", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f20965336aab473fbd768660e152b2f478e6d624255453c23b41d76304679520d2c242d4b7b33a114d5a8d49a4838f75e313a7be48072dbb61de043288cbc2b1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/fb306bf18ab3693f9e50a2f54be9205214fdf3a2b9d1ed9b92a82b50c1b78a0024feec1084af4bc654f578c431db18c4c74eb824d9d782cfa3a323360171fd32"} 09:24:35 INFO - Running post-run listener: copy_logs_to_upload_dir 09:24:35 INFO - Copying logs to upload dir... 09:24:35 INFO - mkdir: /builds/slave/test/build/upload/logs 09:24:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.685322 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-10-06 09:24:35.167789) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 09:24:35.171684) ========= 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=20e666a3d4cfbb71505a330e000001b4-1475769828.740062-2084212502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/42c5ab2fad3459fc37cfd1e981c4e6c7f52af54bb80e65f45acbdbd0f6e88fb7e07809a922fa1412eec6fcc52dc01b9b6fc9b42161b29809185ec35721b91825", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f20965336aab473fbd768660e152b2f478e6d624255453c23b41d76304679520d2c242d4b7b33a114d5a8d49a4838f75e313a7be48072dbb61de043288cbc2b1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/fb306bf18ab3693f9e50a2f54be9205214fdf3a2b9d1ed9b92a82b50c1b78a0024feec1084af4bc654f578c431db18c4c74eb824d9d782cfa3a323360171fd32"} build_url:https://queue.taskcluster.net/v1/task/aKZ051ddRCWuDppQ2Nakqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011394 build_url: 'https://queue.taskcluster.net/v1/task/aKZ051ddRCWuDppQ2Nakqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/42c5ab2fad3459fc37cfd1e981c4e6c7f52af54bb80e65f45acbdbd0f6e88fb7e07809a922fa1412eec6fcc52dc01b9b6fc9b42161b29809185ec35721b91825", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f20965336aab473fbd768660e152b2f478e6d624255453c23b41d76304679520d2c242d4b7b33a114d5a8d49a4838f75e313a7be48072dbb61de043288cbc2b1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/fb306bf18ab3693f9e50a2f54be9205214fdf3a2b9d1ed9b92a82b50c1b78a0024feec1084af4bc654f578c431db18c4c74eb824d9d782cfa3a323360171fd32"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 09:24:35.197931) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 09:24:35.198291) ========= 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=20e666a3d4cfbb71505a330e000001b4-1475769828.740062-2084212502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 09:24:35.283177) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 09:24:35.283506) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 09:24:35.283912) ========= ========= Total master_lag: 0.17 =========