builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-031 starttime: 1475904703.75 results: success (0) buildid: 20161007220122 builduid: 538d9ebec4704199aeb2c77d3c914406 revision: 4429c8701a840b4b08c28507e909a429d37916d5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 22:31:43.754730) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 22:31:43.755389) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 22:31:43.755790) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 22:31:43.788052) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 22:31:43.788358) ========= 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=db0483c52d987ecb441a263b000001ad-1475904651.670711-254927590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-07 22:31:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 31.8M=0s 2016-10-07 22:31:44 (31.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126974 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 22:31:43.929212) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 22:31:43.929586) ========= 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=db0483c52d987ecb441a263b000001ad-1475904651.670711-254927590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019315 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 22:31:43.979470) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 22:31:43.979846) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 4429c8701a840b4b08c28507e909a429d37916d5 --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 4429c8701a840b4b08c28507e909a429d37916d5 --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=db0483c52d987ecb441a263b000001ad-1475904651.670711-254927590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-07 22:31:44,400 truncating revision to first 12 chars 2016-10-07 22:31:44,400 Setting DEBUG logging. 2016-10-07 22:31:44,400 attempt 1/10 2016-10-07 22:31:44,400 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/4429c8701a84?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-07 22:31:44,707 unpacking tar archive at: autoland-4429c8701a84/testing/mozharness/ program finished with exit code 0 elapsedTime=0.621569 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 22:31:44.618340) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 22:31:44.618874) ========= script_repo_revision: 4429c8701a840b4b08c28507e909a429d37916d5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 22:31:44.619510) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 22:31:44.619964) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 22:31:44.631553) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-07 22:31:44.631919) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=db0483c52d987ecb441a263b000001ad-1475904651.670711-254927590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:31:45 INFO - MultiFileLogger online at 20161007 22:31:45 in /builds/slave/test 22:31:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 22:31:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:31:45 INFO - {'append_to_log': False, 22:31:45 INFO - 'base_work_dir': '/builds/slave/test', 22:31:45 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 22:31:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:31:45 INFO - 'branch': 'Autoland-Non-PGO', 22:31:45 INFO - 'buildbot_json_path': 'buildprops.json', 22:31:45 INFO - 'config_files': ('talos/linux_config.py',), 22:31:45 INFO - 'default_actions': ('clobber', 22:31:45 INFO - 'read-buildbot-config', 22:31:45 INFO - 'download-and-extract', 22:31:45 INFO - 'populate-webroot', 22:31:45 INFO - 'create-virtualenv', 22:31:45 INFO - 'install', 22:31:45 INFO - 'run-tests'), 22:31:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:31:45 INFO - 'download_minidump_stackwalk': True, 22:31:45 INFO - 'download_symbols': 'ondemand', 22:31:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:31:45 INFO - 'tooltool.py': '/tools/tooltool.py', 22:31:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:31:45 INFO - '/tools/misc-python/virtualenv.py')}, 22:31:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:31:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:31:45 INFO - 'installer_path': 'installer.exe', 22:31:45 INFO - 'log_level': 'info', 22:31:45 INFO - 'log_name': 'talos', 22:31:45 INFO - 'log_to_console': True, 22:31:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:31:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:31:45 INFO - 'opt_config_files': (), 22:31:45 INFO - 'pip_index': False, 22:31:45 INFO - 'sps_profile': False, 22:31:45 INFO - 'sps_profile_interval': 0, 22:31:45 INFO - 'suite': 'dromaeojs', 22:31:45 INFO - 'system_bits': '32', 22:31:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:31:45 INFO - 'title': 'talos-linux64-ix-031', 22:31:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:31:45 INFO - 'use_talos_json': True, 22:31:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:31:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:31:45 INFO - 'work_dir': 'build'} 22:31:45 INFO - [mozharness: 2016-10-08 05:31:45.148336Z] Running clobber step. 22:31:45 INFO - Running pre-action listener: _resource_record_pre_action 22:31:45 INFO - Running main action method: clobber 22:31:45 INFO - rmtree: /builds/slave/test/build 22:31:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:31:45 INFO - Running post-action listener: _resource_record_post_action 22:31:45 INFO - [mozharness: 2016-10-08 05:31:45.612190Z] Finished clobber step (success) 22:31:45 INFO - [mozharness: 2016-10-08 05:31:45.612291Z] Running read-buildbot-config step. 22:31:45 INFO - Running pre-action listener: _resource_record_pre_action 22:31:45 INFO - Running main action method: read_buildbot_config 22:31:45 INFO - Using buildbot properties: 22:31:45 INFO - { 22:31:45 INFO - "project": "", 22:31:45 INFO - "product": "firefox", 22:31:45 INFO - "script_repo_revision": "production", 22:31:45 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 22:31:45 INFO - "repository": "", 22:31:45 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 22:31:45 INFO - "buildid": "20161007220122", 22:31:45 INFO - "pgo_build": "False", 22:31:45 INFO - "basedir": "/builds/slave/test", 22:31:45 INFO - "buildnumber": 823, 22:31:45 INFO - "slavename": "talos-linux64-ix-031", 22:31:45 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:31:45 INFO - "platform": "ubuntu64_hw", 22:31:45 INFO - "scheduler": "tests-autoland-linux64-talos", 22:31:45 INFO - "branch": "autoland", 22:31:45 INFO - "repo_path": "integration/autoland", 22:31:45 INFO - "revision": "4429c8701a840b4b08c28507e909a429d37916d5", 22:31:45 INFO - "stage_platform": "linux64", 22:31:45 INFO - "builduid": "538d9ebec4704199aeb2c77d3c914406", 22:31:45 INFO - "slavebuilddir": "test" 22:31:45 INFO - } 22:31:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/YyYrXhKeS9GaXi3fepA18A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 22:31:45 INFO - Running post-action listener: _resource_record_post_action 22:31:45 INFO - [mozharness: 2016-10-08 05:31:45.614725Z] Finished read-buildbot-config step (success) 22:31:45 INFO - [mozharness: 2016-10-08 05:31:45.614813Z] Running download-and-extract step. 22:31:45 INFO - Running pre-action listener: _resource_record_pre_action 22:31:45 INFO - Running main action method: download_and_extract 22:31:45 INFO - mkdir: /builds/slave/test/build/tests 22:31:45 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')]} 22:31:45 INFO - trying https://queue.taskcluster.net/v1/task/YyYrXhKeS9GaXi3fepA18A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:31:45 INFO - Downloading https://queue.taskcluster.net/v1/task/YyYrXhKeS9GaXi3fepA18A/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 22:31:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YyYrXhKeS9GaXi3fepA18A/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 22:31:46 INFO - Downloaded 1361 bytes. 22:31:46 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:31:46 INFO - Using the following test package requirements: 22:31:46 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 22:31:46 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:31:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:31:46 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:31:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:31:46 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:31:46 INFO - u'jsshell-linux-x86_64.zip'], 22:31:46 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:31:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:31:46 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 22:31:46 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:31:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:31:46 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:31:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:31:46 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:31:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:31:46 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:31:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:31:46 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:31:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YyYrXhKeS9GaXi3fepA18A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 22:31:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YyYrXhKeS9GaXi3fepA18A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:31:46 INFO - Fetch https://queue.taskcluster.net/v1/task/YyYrXhKeS9GaXi3fepA18A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:31:46 INFO - Http code: 200 22:31:46 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 22:31:46 INFO - x-amz-cf-id: KzhU6f0vy0neHEFSs8-WyhIOFlR8pQ8dBZ44e4qOirfIybAG4RSmAw== 22:31:46 INFO - x-amz-version-id: z7mLAGkTMVTN8UTijco5vuoDy8fxGYU. 22:31:47 INFO - Expected file size: 20525180 22:31:47 INFO - Obtained file size: 20525180 22:31:51 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 22:31:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YyYrXhKeS9GaXi3fepA18A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 22:31:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YyYrXhKeS9GaXi3fepA18A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:31:51 INFO - Fetch https://queue.taskcluster.net/v1/task/YyYrXhKeS9GaXi3fepA18A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:31:51 INFO - Http code: 200 22:31:51 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 22:31:51 INFO - x-amz-cf-id: OUVM0sleNpqRUHs7iyIxOVov_gWSpfuOFGRtjGQyv0wHrvkuGGVa2w== 22:31:51 INFO - x-amz-version-id: z7mLAGkTMVTN8UTijco5vuoDy8fxGYU. 22:31:51 INFO - Expected file size: 20525180 22:31:51 INFO - Obtained file size: 20525180 22:31:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YyYrXhKeS9GaXi3fepA18A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 22:31:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YyYrXhKeS9GaXi3fepA18A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:31:56 INFO - Fetch https://queue.taskcluster.net/v1/task/YyYrXhKeS9GaXi3fepA18A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 22:31:57 INFO - Http code: 200 22:31:57 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 22:31:57 INFO - x-amz-cf-id: E-FMtXuXxKM9O5wE5ZNu6bvbQiz6fQdszTg3S1LjVgPh42kA8_j2HA== 22:31:57 INFO - x-amz-version-id: snvPlu26mugRthaPwRqKZlbZHYgTt52t 22:31:57 INFO - Expected file size: 14409006 22:31:57 INFO - Obtained file size: 14409006 22:31:57 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')]} 22:31:57 INFO - trying https://queue.taskcluster.net/v1/task/YyYrXhKeS9GaXi3fepA18A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:31:57 INFO - Downloading https://queue.taskcluster.net/v1/task/YyYrXhKeS9GaXi3fepA18A/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 22:31:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YyYrXhKeS9GaXi3fepA18A/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 22:31:58 INFO - Downloaded 55814444 bytes. 22:31:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YyYrXhKeS9GaXi3fepA18A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:31:58 INFO - mkdir: /builds/slave/test/properties 22:31:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:31:58 INFO - Writing to file /builds/slave/test/properties/build_url 22:31:58 INFO - Contents: 22:31:58 INFO - build_url:https://queue.taskcluster.net/v1/task/YyYrXhKeS9GaXi3fepA18A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:31:59 INFO - Running post-action listener: _resource_record_post_action 22:31:59 INFO - Running post-action listener: set_extra_try_arguments 22:31:59 INFO - [mozharness: 2016-10-08 05:31:59.268452Z] Finished download-and-extract step (success) 22:31:59 INFO - [mozharness: 2016-10-08 05:31:59.268749Z] Running populate-webroot step. 22:31:59 INFO - Running pre-action listener: _resource_record_pre_action 22:31:59 INFO - Running main action method: populate_webroot 22:31:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:31:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:31:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:31:59 INFO - '--tppagecycles', 22:31:59 INFO - '7'], 22:31:59 INFO - 'tests': ['tsvgm']}}, 22:31:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:31:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:31:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:31:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:31:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:31:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:31:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:31:59 INFO - 'talos_options': ['--disable-e10s'], 22:31:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:31:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:31:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:31:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:31:59 INFO - 'talos_options': ['--disable-e10s'], 22:31:59 INFO - 'tests': ['damp', 'tps']}, 22:31:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:31:59 INFO - 'tests': ['damp', 'tps']}, 22:31:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:31:59 INFO - 'tests': ['dromaeo_dom']}, 22:31:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:31:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:31:59 INFO - 'tests': ['basic_compositor_video']}, 22:31:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:31:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:31:59 INFO - 'tests': ['a11yr', 22:31:59 INFO - 'ts_paint', 22:31:59 INFO - 'tpaint', 22:31:59 INFO - 'sessionrestore', 22:31:59 INFO - 'sessionrestore_no_auto_restore', 22:31:59 INFO - 'tabpaint']}, 22:31:59 INFO - 'other-e10s': {'tests': ['a11yr', 22:31:59 INFO - 'ts_paint', 22:31:59 INFO - 'tpaint', 22:31:59 INFO - 'sessionrestore', 22:31:59 INFO - 'sessionrestore_no_auto_restore', 22:31:59 INFO - 'tabpaint']}, 22:31:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:31:59 INFO - 'ts_paint', 22:31:59 INFO - 'tpaint', 22:31:59 INFO - 'sessionrestore', 22:31:59 INFO - 'sessionrestore_no_auto_restore', 22:31:59 INFO - 'tabpaint']}, 22:31:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:31:59 INFO - 'ts_paint', 22:31:59 INFO - 'tpaint', 22:31:59 INFO - 'sessionrestore', 22:31:59 INFO - 'sessionrestore_no_auto_restore', 22:31:59 INFO - 'tabpaint']}, 22:31:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:31:59 INFO - 'tests': ['a11yr', 22:31:59 INFO - 'ts_paint', 22:31:59 INFO - 'tpaint', 22:31:59 INFO - 'sessionrestore', 22:31:59 INFO - 'sessionrestore_no_auto_restore', 22:31:59 INFO - 'tabpaint']}, 22:31:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:31:59 INFO - 'tests': ['a11yr', 22:31:59 INFO - 'ts_paint', 22:31:59 INFO - 'tpaint', 22:31:59 INFO - 'sessionrestore', 22:31:59 INFO - 'sessionrestore_no_auto_restore', 22:31:59 INFO - 'tabpaint']}, 22:31:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:31:59 INFO - 'tests': ['tsvgx', 22:31:59 INFO - 'tsvgr_opacity', 22:31:59 INFO - 'tart', 22:31:59 INFO - 'tscrollx', 22:31:59 INFO - 'cart']}, 22:31:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:31:59 INFO - 'tsvgr_opacity', 22:31:59 INFO - 'tart', 22:31:59 INFO - 'tscrollx', 22:31:59 INFO - 'cart']}, 22:31:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:31:59 INFO - 'talos_options': ['--disable-e10s'], 22:31:59 INFO - 'tests': ['tp5o']}, 22:31:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:31:59 INFO - 'tests': ['tp5o']}, 22:31:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:31:59 INFO - 'talos_options': ['--disable-e10s', 22:31:59 INFO - '--xperf_path', 22:31:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:31:59 INFO - 'tests': ['tp5n']}, 22:31:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:31:59 INFO - 'talos_options': ['--xperf_path', 22:31:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:31:59 INFO - 'tests': ['tp5n']}}, 22:31:59 INFO - 'talos.zip': {'path': '', 22:31:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:31:59 INFO - Running post-action listener: _resource_record_post_action 22:31:59 INFO - [mozharness: 2016-10-08 05:31:59.290730Z] Finished populate-webroot step (success) 22:31:59 INFO - [mozharness: 2016-10-08 05:31:59.290823Z] Running create-virtualenv step. 22:31:59 INFO - Running pre-action listener: _resource_record_pre_action 22:31:59 INFO - Running main action method: create_virtualenv 22:31:59 INFO - Creating virtualenv /builds/slave/test/build/venv 22:31:59 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 22:31:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:31:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:31:59 INFO - Using real prefix '/usr' 22:31:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:31:59 INFO - Installing distribute.............................................................................................................................................................................................done. 22:32:01 INFO - Installing pip.................done. 22:32:01 INFO - Return code: 0 22:32:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:32:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:32:02 INFO - Reading from file tmpfile_stdout 22:32:02 INFO - Output received: 22:32:02 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) 22:32:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:32:02 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')]} 22:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:32:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:32:02 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')]} 22:32:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:32:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:32:02 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 0x7fa719d96f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1468ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1465f60>, '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 0x1466d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14671d0>, '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': 'db0483c52d987ecb441a263b000001ad-1475904651.670711-254927590', '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 22:32:02 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 22:32:02 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 22:32:02 INFO - Using env: {'DISPLAY': ':0', 22:32:02 INFO - 'HOME': '/home/cltbld', 22:32:02 INFO - 'LANG': 'en_US.UTF-8', 22:32:02 INFO - 'LANGUAGE': 'en_US:en', 22:32:02 INFO - 'LOGNAME': 'cltbld', 22:32:02 INFO - 'MAIL': '/var/mail/cltbld', 22:32:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:32:02 INFO - 'MOZ_NO_REMOTE': '1', 22:32:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:32:02 INFO - 'NO_EM_RESTART': '1', 22:32:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:32:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:32:02 INFO - 'PWD': '/builds/slave/test', 22:32:02 INFO - 'SHELL': '/bin/bash', 22:32:02 INFO - 'SHLVL': '1', 22:32:02 INFO - 'TERM': 'linux', 22:32:02 INFO - 'TMOUT': '86400', 22:32:02 INFO - 'USER': 'cltbld', 22:32:02 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475904651.670711-254927590', 22:32:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:32:02 INFO - '_': '/tools/buildbot/bin/python'} 22:32:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:32:02 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 22:32:02 INFO - Cleaning up... 22:32:02 INFO - Return code: 0 22:32:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:32:02 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')]} 22:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:32:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:32:02 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')]} 22:32:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:32:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:32:02 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 0x7fa719d96f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1468ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1465f60>, '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 0x1466d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14671d0>, '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': 'db0483c52d987ecb441a263b000001ad-1475904651.670711-254927590', '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 22:32:02 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 22:32:02 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 22:32:02 INFO - Using env: {'DISPLAY': ':0', 22:32:02 INFO - 'HOME': '/home/cltbld', 22:32:02 INFO - 'LANG': 'en_US.UTF-8', 22:32:02 INFO - 'LANGUAGE': 'en_US:en', 22:32:02 INFO - 'LOGNAME': 'cltbld', 22:32:02 INFO - 'MAIL': '/var/mail/cltbld', 22:32:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:32:02 INFO - 'MOZ_NO_REMOTE': '1', 22:32:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:32:02 INFO - 'NO_EM_RESTART': '1', 22:32:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:32:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:32:02 INFO - 'PWD': '/builds/slave/test', 22:32:02 INFO - 'SHELL': '/bin/bash', 22:32:02 INFO - 'SHLVL': '1', 22:32:02 INFO - 'TERM': 'linux', 22:32:02 INFO - 'TMOUT': '86400', 22:32:02 INFO - 'USER': 'cltbld', 22:32:02 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475904651.670711-254927590', 22:32:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:32:02 INFO - '_': '/tools/buildbot/bin/python'} 22:32:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:32:02 INFO - Downloading/unpacking psutil>=3.1.1 22:32:02 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 22:32:02 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 22:32:02 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 22:32:02 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 22:32:02 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 22:32:02 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 22:32:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:32:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:32:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:32:04 INFO - Installing collected packages: psutil 22:32:04 INFO - Running setup.py install for psutil 22:32:04 INFO - building 'psutil._psutil_linux' extension 22:32:04 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 22:32:04 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 22:32:04 INFO - building 'psutil._psutil_posix' extension 22:32:04 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 22:32:04 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 22:32:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:32:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:32:05 INFO - Successfully installed psutil 22:32:05 INFO - Cleaning up... 22:32:05 INFO - Return code: 0 22:32:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:32:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:32:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:32:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:32:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa719d96f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1468ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1465f60>, '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 0x1466d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14671d0>, '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': 'db0483c52d987ecb441a263b000001ad-1475904651.670711-254927590', '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 22:32:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 22:32:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 22:32:05 INFO - Using env: {'DISPLAY': ':0', 22:32:05 INFO - 'HOME': '/home/cltbld', 22:32:05 INFO - 'LANG': 'en_US.UTF-8', 22:32:05 INFO - 'LANGUAGE': 'en_US:en', 22:32:05 INFO - 'LOGNAME': 'cltbld', 22:32:05 INFO - 'MAIL': '/var/mail/cltbld', 22:32:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:32:05 INFO - 'MOZ_NO_REMOTE': '1', 22:32:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:32:05 INFO - 'NO_EM_RESTART': '1', 22:32:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:32:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:32:05 INFO - 'PWD': '/builds/slave/test', 22:32:05 INFO - 'SHELL': '/bin/bash', 22:32:05 INFO - 'SHLVL': '1', 22:32:05 INFO - 'TERM': 'linux', 22:32:05 INFO - 'TMOUT': '86400', 22:32:05 INFO - 'USER': 'cltbld', 22:32:05 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475904651.670711-254927590', 22:32:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:32:05 INFO - '_': '/tools/buildbot/bin/python'} 22:32:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:32:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:32:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:32:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:32:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:32:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:32:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:32:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:32:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:32:07 INFO - Installing collected packages: mozsystemmonitor 22:32:07 INFO - Running setup.py install for mozsystemmonitor 22:32:07 INFO - Successfully installed mozsystemmonitor 22:32:07 INFO - Cleaning up... 22:32:07 INFO - Return code: 0 22:32:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:32: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')]} 22:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:32:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:32: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')]} 22:32:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:32:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:32: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', '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 0x7fa719d96f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1468ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1465f60>, '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 0x1466d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14671d0>, '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': 'db0483c52d987ecb441a263b000001ad-1475904651.670711-254927590', '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 22:32: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 22:32: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 jsonschema==2.5.1 22:32:07 INFO - Using env: {'DISPLAY': ':0', 22:32:07 INFO - 'HOME': '/home/cltbld', 22:32:07 INFO - 'LANG': 'en_US.UTF-8', 22:32:07 INFO - 'LANGUAGE': 'en_US:en', 22:32:07 INFO - 'LOGNAME': 'cltbld', 22:32:07 INFO - 'MAIL': '/var/mail/cltbld', 22:32:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:32:07 INFO - 'MOZ_NO_REMOTE': '1', 22:32:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:32:07 INFO - 'NO_EM_RESTART': '1', 22:32:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:32:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:32:07 INFO - 'PWD': '/builds/slave/test', 22:32:07 INFO - 'SHELL': '/bin/bash', 22:32:07 INFO - 'SHLVL': '1', 22:32:07 INFO - 'TERM': 'linux', 22:32:07 INFO - 'TMOUT': '86400', 22:32:07 INFO - 'USER': 'cltbld', 22:32:07 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475904651.670711-254927590', 22:32:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:32:07 INFO - '_': '/tools/buildbot/bin/python'} 22:32:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:32:07 INFO - Downloading/unpacking jsonschema==2.5.1 22:32:07 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 22:32:07 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 22:32:07 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 22:32:07 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 22:32:07 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 22:32:07 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 22:32:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:32:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:32:09 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 22:32:09 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 22:32:09 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 22:32:09 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 22:32:09 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 22:32:09 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 22:32:09 INFO - Downloading functools32-3.2.3-2.tar.gz 22:32:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:32:09 INFO - warning: no files found matching '*.txt' 22:32:09 INFO - no previously-included directories found matching 'build' 22:32:09 INFO - no previously-included directories found matching 'dist' 22:32:09 INFO - no previously-included directories found matching '.git*' 22:32:09 INFO - Installing collected packages: jsonschema, functools32 22:32:09 INFO - Running setup.py install for functools32 22:32:09 INFO - warning: no files found matching '*.txt' 22:32:09 INFO - no previously-included directories found matching 'build' 22:32:09 INFO - no previously-included directories found matching 'dist' 22:32:09 INFO - no previously-included directories found matching '.git*' 22:32:09 INFO - Successfully installed jsonschema functools32 22:32:09 INFO - Cleaning up... 22:32:09 INFO - Return code: 0 22:32:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:32:09 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')]} 22:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:32:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:32:09 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')]} 22:32:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:32:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:32:09 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 0x7fa719d96f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1468ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1465f60>, '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 0x1466d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14671d0>, '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': 'db0483c52d987ecb441a263b000001ad-1475904651.670711-254927590', '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 22:32:09 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 22:32:09 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 22:32:09 INFO - Using env: {'DISPLAY': ':0', 22:32:09 INFO - 'HOME': '/home/cltbld', 22:32:09 INFO - 'LANG': 'en_US.UTF-8', 22:32:09 INFO - 'LANGUAGE': 'en_US:en', 22:32:09 INFO - 'LOGNAME': 'cltbld', 22:32:09 INFO - 'MAIL': '/var/mail/cltbld', 22:32:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:32:09 INFO - 'MOZ_NO_REMOTE': '1', 22:32:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:32:09 INFO - 'NO_EM_RESTART': '1', 22:32:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:32:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:32:09 INFO - 'PWD': '/builds/slave/test', 22:32:09 INFO - 'SHELL': '/bin/bash', 22:32:09 INFO - 'SHLVL': '1', 22:32:09 INFO - 'TERM': 'linux', 22:32:09 INFO - 'TMOUT': '86400', 22:32:09 INFO - 'USER': 'cltbld', 22:32:09 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475904651.670711-254927590', 22:32:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:32:09 INFO - '_': '/tools/buildbot/bin/python'} 22:32:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:32:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:32:10 INFO - Cleaning up... 22:32:10 INFO - Return code: 0 22:32:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:32: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')]} 22:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:32:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:32: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')]} 22:32:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:32:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:32: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', '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 0x7fa719d96f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1468ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1465f60>, '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 0x1466d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14671d0>, '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': 'db0483c52d987ecb441a263b000001ad-1475904651.670711-254927590', '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 22:32: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:32: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 blobuploader==1.2.4 22:32:10 INFO - Using env: {'DISPLAY': ':0', 22:32:10 INFO - 'HOME': '/home/cltbld', 22:32:10 INFO - 'LANG': 'en_US.UTF-8', 22:32:10 INFO - 'LANGUAGE': 'en_US:en', 22:32:10 INFO - 'LOGNAME': 'cltbld', 22:32:10 INFO - 'MAIL': '/var/mail/cltbld', 22:32:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:32:10 INFO - 'MOZ_NO_REMOTE': '1', 22:32:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:32:10 INFO - 'NO_EM_RESTART': '1', 22:32:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:32:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:32:10 INFO - 'PWD': '/builds/slave/test', 22:32:10 INFO - 'SHELL': '/bin/bash', 22:32:10 INFO - 'SHLVL': '1', 22:32:10 INFO - 'TERM': 'linux', 22:32:10 INFO - 'TMOUT': '86400', 22:32:10 INFO - 'USER': 'cltbld', 22:32:10 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475904651.670711-254927590', 22:32:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:32:10 INFO - '_': '/tools/buildbot/bin/python'} 22:32:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:32:10 INFO - Downloading/unpacking blobuploader==1.2.4 22:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:32:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:32:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:32:12 INFO - Downloading blobuploader-1.2.4.tar.gz 22:32:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:32:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:32:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:32:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:32:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:32:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:32:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:32:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:32:12 INFO - Downloading docopt-0.6.1.tar.gz 22:32:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:32:13 INFO - Installing collected packages: blobuploader, requests, docopt 22:32:13 INFO - Running setup.py install for blobuploader 22:32:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:32:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:32:13 INFO - Running setup.py install for requests 22:32:13 INFO - Running setup.py install for docopt 22:32:13 INFO - Successfully installed blobuploader requests docopt 22:32:13 INFO - Cleaning up... 22:32:13 INFO - Return code: 0 22:32:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:32: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')]} 22:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:32:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:32: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')]} 22:32:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:32:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:32:13 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 0x7fa719d96f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1468ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1465f60>, '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 0x1466d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14671d0>, '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': 'db0483c52d987ecb441a263b000001ad-1475904651.670711-254927590', '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 22:32:13 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 22:32:13 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 22:32:13 INFO - Using env: {'DISPLAY': ':0', 22:32:13 INFO - 'HOME': '/home/cltbld', 22:32:13 INFO - 'LANG': 'en_US.UTF-8', 22:32:13 INFO - 'LANGUAGE': 'en_US:en', 22:32:13 INFO - 'LOGNAME': 'cltbld', 22:32:13 INFO - 'MAIL': '/var/mail/cltbld', 22:32:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:32:13 INFO - 'MOZ_NO_REMOTE': '1', 22:32:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:32:13 INFO - 'NO_EM_RESTART': '1', 22:32:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:32:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:32:13 INFO - 'PWD': '/builds/slave/test', 22:32:13 INFO - 'SHELL': '/bin/bash', 22:32:13 INFO - 'SHLVL': '1', 22:32:13 INFO - 'TERM': 'linux', 22:32:13 INFO - 'TMOUT': '86400', 22:32:13 INFO - 'USER': 'cltbld', 22:32:13 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475904651.670711-254927590', 22:32:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:32:13 INFO - '_': '/tools/buildbot/bin/python'} 22:32:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:32:13 INFO - Running setup.py (path:/tmp/pip-pCWsFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:32:13 INFO - Running setup.py (path:/tmp/pip-fzHYML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:32:14 INFO - Running setup.py (path:/tmp/pip-JzCUbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:32:14 INFO - Running setup.py (path:/tmp/pip-qivkTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:32:14 INFO - Running setup.py (path:/tmp/pip-cdLxrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:32:14 INFO - Running setup.py (path:/tmp/pip-zgT8Zm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:32:14 INFO - Running setup.py (path:/tmp/pip-8KMvBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:32:14 INFO - Running setup.py (path:/tmp/pip-e5rNso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:32:14 INFO - Running setup.py (path:/tmp/pip-8MF8Dq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:32:14 INFO - Running setup.py (path:/tmp/pip-BTPApO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:32:14 INFO - Running setup.py (path:/tmp/pip-Eboytp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:32:14 INFO - Running setup.py (path:/tmp/pip-uh0Hrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:32:14 INFO - Running setup.py (path:/tmp/pip-lLMJ6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:32:14 INFO - Running setup.py (path:/tmp/pip-IGJhol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:32:14 INFO - Running setup.py (path:/tmp/pip-GdnpFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:32:14 INFO - Running setup.py (path:/tmp/pip-tOUGah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:32:15 INFO - Running setup.py (path:/tmp/pip-XTik9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:32:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:32:15 INFO - Running setup.py install for manifestparser 22:32:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:32:15 INFO - Running setup.py install for mozcrash 22:32:15 INFO - Running setup.py install for mozdebug 22:32:15 INFO - Running setup.py install for mozdevice 22:32:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:32:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:32:15 INFO - Running setup.py install for mozfile 22:32:15 INFO - Running setup.py install for mozhttpd 22:32:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:32:15 INFO - Running setup.py install for mozinfo 22:32:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:32:15 INFO - Running setup.py install for mozInstall 22:32:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:32:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:32:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:32:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:32:15 INFO - Running setup.py install for mozleak 22:32:15 INFO - Running setup.py install for mozlog 22:32:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:32:16 INFO - Running setup.py install for moznetwork 22:32:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:32:16 INFO - Running setup.py install for mozprocess 22:32:16 INFO - Running setup.py install for mozprofile 22:32:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:32:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:32:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:32:16 INFO - Running setup.py install for mozrunner 22:32:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:32:16 INFO - Running setup.py install for mozscreenshot 22:32:16 INFO - Running setup.py install for moztest 22:32:16 INFO - Running setup.py install for mozversion 22:32:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:32:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:32:16 INFO - Cleaning up... 22:32:16 INFO - Return code: 0 22:32:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:32: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')]} 22:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:32:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:32: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')]} 22:32:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:32:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:32:16 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 0x7fa719d96f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1468ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1465f60>, '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 0x1466d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14671d0>, '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': 'db0483c52d987ecb441a263b000001ad-1475904651.670711-254927590', '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 22:32:16 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 22:32:16 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 22:32:16 INFO - Using env: {'DISPLAY': ':0', 22:32:16 INFO - 'HOME': '/home/cltbld', 22:32:16 INFO - 'LANG': 'en_US.UTF-8', 22:32:16 INFO - 'LANGUAGE': 'en_US:en', 22:32:16 INFO - 'LOGNAME': 'cltbld', 22:32:16 INFO - 'MAIL': '/var/mail/cltbld', 22:32:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:32:16 INFO - 'MOZ_NO_REMOTE': '1', 22:32:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:32:16 INFO - 'NO_EM_RESTART': '1', 22:32:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:32:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:32:16 INFO - 'PWD': '/builds/slave/test', 22:32:16 INFO - 'SHELL': '/bin/bash', 22:32:16 INFO - 'SHLVL': '1', 22:32:16 INFO - 'TERM': 'linux', 22:32:16 INFO - 'TMOUT': '86400', 22:32:16 INFO - 'USER': 'cltbld', 22:32:16 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475904651.670711-254927590', 22:32:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:32:16 INFO - '_': '/tools/buildbot/bin/python'} 22:32:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:32:17 INFO - Running setup.py (path:/tmp/pip-7MOGZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:32:17 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)) 22:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:32:17 INFO - Running setup.py (path:/tmp/pip-30bFRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:32:17 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)) 22:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:32:17 INFO - Running setup.py (path:/tmp/pip-Q_Zq0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:32:17 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)) 22:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:32:17 INFO - Running setup.py (path:/tmp/pip-s0LGYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:32:17 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)) 22:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:32:17 INFO - Running setup.py (path:/tmp/pip-BSTnEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:32:17 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)) 22:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:32:17 INFO - Running setup.py (path:/tmp/pip-n9WnvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:32:17 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)) 22:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:32:17 INFO - Running setup.py (path:/tmp/pip-t3DjHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:32:17 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)) 22:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:32:17 INFO - Running setup.py (path:/tmp/pip-uIrxtQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:32:17 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)) 22:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:32:17 INFO - Running setup.py (path:/tmp/pip-My5Uw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:32:17 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)) 22:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:32:17 INFO - Running setup.py (path:/tmp/pip-dSCxjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:32:17 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)) 22:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:32:17 INFO - Running setup.py (path:/tmp/pip-y6XYze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:32:17 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)) 22:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:32:17 INFO - Running setup.py (path:/tmp/pip-3JSROc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:32:18 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)) 22:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:32:18 INFO - Running setup.py (path:/tmp/pip-S_fXr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:32:18 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)) 22:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:32:18 INFO - Running setup.py (path:/tmp/pip-3GCsP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:32:18 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)) 22:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:32:18 INFO - Running setup.py (path:/tmp/pip-i1SRFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:32:18 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)) 22:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:32:18 INFO - Running setup.py (path:/tmp/pip-LuCvKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:32:18 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)) 22:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:32:18 INFO - Running setup.py (path:/tmp/pip-AoVIf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:32:18 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)) 22:32:18 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)) 22:32:18 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)) 22:32:18 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)) 22:32:18 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)) 22:32:18 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)) 22:32:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:32: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 22:32: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 22:32: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 22:32: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 22:32: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 22:32: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 22:32:20 INFO - Downloading blessings-1.6.tar.gz 22:32:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:32:20 INFO - Installing collected packages: blessings 22:32:20 INFO - Running setup.py install for blessings 22:32:20 INFO - Successfully installed blessings 22:32:20 INFO - Cleaning up... 22:32:20 INFO - Return code: 0 22:32:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:32:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:32:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:32:20 INFO - Reading from file tmpfile_stdout 22:32:20 INFO - Current package versions: 22:32:20 INFO - argparse == 1.2.1 22:32:20 INFO - blessings == 1.6 22:32:20 INFO - blobuploader == 1.2.4 22:32:20 INFO - docopt == 0.6.1 22:32:20 INFO - functools32 == 3.2.3-2 22:32:20 INFO - jsonschema == 2.5.1 22:32:20 INFO - manifestparser == 1.1 22:32:20 INFO - mozInstall == 1.12 22:32:20 INFO - mozcrash == 0.17 22:32:20 INFO - mozdebug == 0.1 22:32:20 INFO - mozdevice == 0.48 22:32:20 INFO - mozfile == 1.2 22:32:20 INFO - mozhttpd == 0.7 22:32:20 INFO - mozinfo == 0.9 22:32:20 INFO - mozleak == 0.1 22:32:20 INFO - mozlog == 3.4 22:32:20 INFO - moznetwork == 0.27 22:32:20 INFO - mozprocess == 0.23 22:32:20 INFO - mozprofile == 0.28 22:32:20 INFO - mozrunner == 6.12 22:32:20 INFO - mozscreenshot == 0.1 22:32:20 INFO - mozsystemmonitor == 0.3 22:32:20 INFO - moztest == 0.7 22:32:20 INFO - mozversion == 1.4 22:32:20 INFO - psutil == 3.1.1 22:32:20 INFO - requests == 1.2.3 22:32:20 INFO - wsgiref == 0.1.2 22:32:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:32:20 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')]} 22:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:32:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:32:20 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')]} 22:32:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:32:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:32:20 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 0x7fa719d96f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1468ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1465f60>, '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 0x1466d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14671d0>, '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': 'db0483c52d987ecb441a263b000001ad-1475904651.670711-254927590', '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 22:32:20 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 22:32:20 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 22:32:20 INFO - Using env: {'DISPLAY': ':0', 22:32:20 INFO - 'HOME': '/home/cltbld', 22:32:20 INFO - 'LANG': 'en_US.UTF-8', 22:32:20 INFO - 'LANGUAGE': 'en_US:en', 22:32:20 INFO - 'LOGNAME': 'cltbld', 22:32:20 INFO - 'MAIL': '/var/mail/cltbld', 22:32:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:32:20 INFO - 'MOZ_NO_REMOTE': '1', 22:32:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:32:20 INFO - 'NO_EM_RESTART': '1', 22:32:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:32:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:32:20 INFO - 'PWD': '/builds/slave/test', 22:32:20 INFO - 'SHELL': '/bin/bash', 22:32:20 INFO - 'SHLVL': '1', 22:32:20 INFO - 'TERM': 'linux', 22:32:20 INFO - 'TMOUT': '86400', 22:32:20 INFO - 'USER': 'cltbld', 22:32:20 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475904651.670711-254927590', 22:32:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:32:20 INFO - '_': '/tools/buildbot/bin/python'} 22:32:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:32:21 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)) 22:32:21 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)) 22:32:21 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)) 22:32:21 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)) 22:32:21 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)) 22:32:21 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)) 22:32:21 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)) 22:32:21 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)) 22:32:21 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)) 22:32:21 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)) 22:32:21 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)) 22:32:21 INFO - Cleaning up... 22:32:21 INFO - Return code: 0 22:32:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:32:21 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')]} 22:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:32:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:32:21 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')]} 22:32:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:32:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:32:21 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 0x7fa719d96f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1468ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1465f60>, '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 0x1466d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14671d0>, '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': 'db0483c52d987ecb441a263b000001ad-1475904651.670711-254927590', '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 22:32:21 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 22:32:21 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 22:32:21 INFO - Using env: {'DISPLAY': ':0', 22:32:21 INFO - 'HOME': '/home/cltbld', 22:32:21 INFO - 'LANG': 'en_US.UTF-8', 22:32:21 INFO - 'LANGUAGE': 'en_US:en', 22:32:21 INFO - 'LOGNAME': 'cltbld', 22:32:21 INFO - 'MAIL': '/var/mail/cltbld', 22:32:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:32:21 INFO - 'MOZ_NO_REMOTE': '1', 22:32:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:32:21 INFO - 'NO_EM_RESTART': '1', 22:32:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:32:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:32:21 INFO - 'PWD': '/builds/slave/test', 22:32:21 INFO - 'SHELL': '/bin/bash', 22:32:21 INFO - 'SHLVL': '1', 22:32:21 INFO - 'TERM': 'linux', 22:32:21 INFO - 'TMOUT': '86400', 22:32:21 INFO - 'USER': 'cltbld', 22:32:21 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475904651.670711-254927590', 22:32:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:32:21 INFO - '_': '/tools/buildbot/bin/python'} 22:32:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:32:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:32:21 INFO - Cleaning up... 22:32:21 INFO - Return code: 0 22:32:21 INFO - Running post-action listener: _resource_record_post_action 22:32:21 INFO - Running post-action listener: _start_resource_monitoring 22:32:21 INFO - Starting resource monitoring. 22:32:21 INFO - [mozharness: 2016-10-08 05:32:21.301549Z] Finished create-virtualenv step (success) 22:32:21 INFO - [mozharness: 2016-10-08 05:32:21.302510Z] Running install step. 22:32:21 INFO - Running pre-action listener: _resource_record_pre_action 22:32:21 INFO - Running main action method: install 22:32:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:32:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:32:21 INFO - Reading from file tmpfile_stdout 22:32:21 INFO - Detecting whether we're running mozinstall >=1.0... 22:32:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:32:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:32:21 INFO - Reading from file tmpfile_stdout 22:32:21 INFO - Output received: 22:32:21 INFO - Usage: mozinstall [options] installer 22:32:21 INFO - Options: 22:32:21 INFO - -h, --help show this help message and exit 22:32:21 INFO - -d DEST, --destination=DEST 22:32:21 INFO - Directory to install application into. [default: 22:32:21 INFO - "/builds/slave/test"] 22:32:21 INFO - --app=APP Application being installed. [default: firefox] 22:32:21 INFO - mkdir: /builds/slave/test/build/application 22:32:21 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'] 22:32:21 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 22:32:37 INFO - Reading from file tmpfile_stdout 22:32:37 INFO - Output received: 22:32:37 INFO - /builds/slave/test/build/application/firefox/firefox 22:32:37 INFO - Running post-action listener: _resource_record_post_action 22:32:37 INFO - [mozharness: 2016-10-08 05:32:37.728118Z] Finished install step (success) 22:32:37 INFO - [mozharness: 2016-10-08 05:32:37.728362Z] Running run-tests step. 22:32:37 INFO - Running pre-action listener: _resource_record_pre_action 22:32:37 INFO - Running main action method: run_tests 22:32:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:32:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:32:37 INFO - Python 2.7.3 22:32:37 INFO - Return code: 0 22:32:37 INFO - grabbing minidump binary from tooltool 22:32:37 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')]} 22:32:37 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 0x1465f60>, '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 0x1466d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14671d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:32:37 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 22:32:37 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 22:32:37 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 22:32:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:32:37 INFO - Return code: 0 22:32:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:32:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:32:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:32:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:32:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:32:37 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YyYrXhKeS9GaXi3fepA18A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 22:32:37 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YyYrXhKeS9GaXi3fepA18A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 22:32:37 INFO - Using env: {'DISPLAY': ':0', 22:32:37 INFO - 'HOME': '/home/cltbld', 22:32:37 INFO - 'LANG': 'en_US.UTF-8', 22:32:37 INFO - 'LANGUAGE': 'en_US:en', 22:32:37 INFO - 'LOGNAME': 'cltbld', 22:32:37 INFO - 'MAIL': '/var/mail/cltbld', 22:32:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:32:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:32:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:32:37 INFO - 'MOZ_NO_REMOTE': '1', 22:32:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:32:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:32:37 INFO - 'NO_EM_RESTART': '1', 22:32:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:32:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:32:37 INFO - 'PWD': '/builds/slave/test', 22:32:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:32:37 INFO - 'SHELL': '/bin/bash', 22:32:37 INFO - 'SHLVL': '1', 22:32:37 INFO - 'TERM': 'linux', 22:32:37 INFO - 'TMOUT': '86400', 22:32:37 INFO - 'USER': 'cltbld', 22:32:37 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475904651.670711-254927590', 22:32:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:32:37 INFO - '_': '/tools/buildbot/bin/python'} 22:32:37 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YyYrXhKeS9GaXi3fepA18A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 22:32:38 INFO - mozversion application_buildid: 20161007220122 22:32:38 INFO - mozversion application_changeset: 4429c8701a840b4b08c28507e909a429d37916d5 22:32:38 INFO - mozversion application_display_name: Nightly 22:32:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:32:38 INFO - mozversion application_name: Firefox 22:32:38 INFO - mozversion application_remotingname: firefox 22:32:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 22:32:38 INFO - mozversion application_vendor: Mozilla 22:32:38 INFO - mozversion application_version: 52.0a1 22:32:38 INFO - mozversion platform_buildid: 20161007220122 22:32:38 INFO - mozversion platform_changeset: 4429c8701a840b4b08c28507e909a429d37916d5 22:32:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 22:32:38 INFO - mozversion platform_version: 52.0a1 22:32:38 INFO - using testdate: 1475904758 22:32:38 INFO - actual date: 1475904758 22:32:38 INFO - starting webserver on 'localhost:47908' 22:32:38 INFO - SUITE-START | Running 2 tests 22:32:38 INFO - TEST-START | dromaeo_css 22:32:38 INFO - operating with platform_type : linux_ 22:32:38 INFO - Initialising browser for dromaeo_css test... 22:32:38 INFO - TEST-INFO | started process 11767 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkyU3Zg/profile http://localhost:47908/getInfo.html) 22:32:42 INFO - PROCESS | 11767 | __metrics Screen width/height:1600/1200 22:32:42 INFO - PROCESS | 11767 | colorDepth:24 22:32:42 INFO - PROCESS | 11767 | Browser inner width/height: 1024/697 22:32:42 INFO - PROCESS | 11767 | __metrics 22:32:42 INFO - PROCESS | 11767 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:32:42 INFO - PROCESS | 11767 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:32:43 INFO - PROCESS | 11767 | console.error: PushService: 22:32:43 INFO - PROCESS | 11767 | stateChangeProcessEnqueue: Error transitioning state 22:32:43 INFO - PROCESS | 11767 | UnknownError 22:32:44 INFO - TEST-INFO | 11767: exit 0 22:32:44 INFO - Browser initialized. 22:32:44 INFO - Running cycle 1/1 for dromaeo_css test... 22:32:44 INFO - TEST-INFO | started process 11850 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkyU3Zg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:32:56 INFO - PROCESS | 11850 | RSS: Main: 173355008 22:32:56 INFO - PROCESS | 11850 | 22:33:47 INFO - PROCESS | 11850 | 1475904827270 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] 22:36:02 INFO - PROCESS | 11850 | Cycle 1(1): loaded http://localhost:47908/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47908/tests/dromaeo/cssquery-ext.html) 22:36:03 INFO - PROCESS | 11850 | RSS: Main: 310198272 22:36:03 INFO - PROCESS | 11850 | 22:39:06 INFO - PROCESS | 11850 | Cycle 1(1): loaded http://localhost:47908/tests/dromaeo/cssquery-ext.html (next: http://localhost:47908/tests/dromaeo/cssquery-jquery.html) 22:39:06 INFO - PROCESS | 11850 | RSS: Main: 278384640 22:39:06 INFO - PROCESS | 11850 | 22:42:09 INFO - PROCESS | 11850 | Cycle 1(1): loaded http://localhost:47908/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47908/tests/dromaeo/cssquery-mootools.html) 22:42:09 INFO - PROCESS | 11850 | RSS: Main: 242905088 22:42:09 INFO - PROCESS | 11850 | 22:45:11 INFO - PROCESS | 11850 | Cycle 1(1): loaded http://localhost:47908/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47908/tests/dromaeo/cssquery-prototype.html) 22:45:12 INFO - PROCESS | 11850 | RSS: Main: 219439104 22:45:12 INFO - PROCESS | 11850 | 22:48:15 INFO - PROCESS | 11850 | Cycle 1(1): loaded http://localhost:47908/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47908/tests/dromaeo/cssquery-yui.html) 22:48:16 INFO - PROCESS | 11850 | RSS: Main: 220872704 22:48:16 INFO - PROCESS | 11850 | 22:51:18 INFO - PROCESS | 11850 | Cycle 1(1): loaded http://localhost:47908/tests/dromaeo/cssquery-yui.html (next: http://localhost:47908/tests/dromaeo/cssquery-dojo.html) 22:51:19 INFO - PROCESS | 11850 | RSS: Main: 313921536 22:51:19 INFO - PROCESS | 11850 | 22:51:19 INFO - PROCESS | 11850 | __start_tp_report 22:51:19 INFO - PROCESS | 11850 | _x_x_mozilla_page_load 22:51:19 INFO - PROCESS | 11850 | _x_x_mozilla_page_load_details 22:51:19 INFO - PROCESS | 11850 | |i|pagename|runs| 22:51:19 INFO - PROCESS | 11850 | |0;dojo.html;2578.587426011838;2612.882420291087;2657.8139530232893;2658.069675613535;2670.158899946518;4556.293774464955;4645.303204519324;4723.520715969476;4771.570558649716;4844.467108618053;4673.042026384592;4674;4682.204025315696;4684.8126074957045;4693.741844198567;4282.78586070696;4299.054208074219;4305.461817272841;4315.309550471925;4325.437693099892;4321.2653848845775;4359.4768627764715;4409.603135717784;4433.113377324532;4446.15523050621;4446.733196008234;4459.241928872099;4460.130274596455;4515.548445155491;4516.051629157881;4309.267424537836;4401.757903315316;4483.887902802423;4485.484169320537;4487.730736155841;4224.640905523003;4397.428334316551;4406.757628330441;4429.247028005247;4446;4625.190591646448;4666.836660716858;4693.225617773063;4693.906121877578;4721.362616046824;4969.13040217964;4970.502949705001;4974.403071631427;4991.800327986876;5058.7976480940715;5034.899302013976;5073.441921388644;5085.974570127163;5087.79648814047;5120.692758434506;4523.140603285366;4563.269876819693;4677.672562920563;4721.905561888743;4786;5154.098032844237;5195.922061169085;5199.142141546602;5202.635815492955;5254.816081437131;4982.476839931827;4993.90012199754;4994;4995.500449955048;5057.115004874132;4836.395450568679;4905.2151655734915;4973.975130124399;5031;5071.264666623319;4991.326170966873;4994.275830004629;5018.222175562793;5054.21659642756;5056.721880296619;4961.4046314441775;4975.2288395298065;4977.9751101244265;4978.153713868651;5034.0686972910125;4156.854510092132;4202.096549241927;4207.158568286355;4252.277112890816;4253.787310634456;3682.8710995115043;3727.962720372816;3733.328000959799;3735.7571757835653;3806.3719486284454;4390;4391.538888416734;4401.559844015637;4439.067795762861;4449.866504004885;4887.266909963534;4958.504149585013;5086.64393492452;5107.387113546324;5108.412532558729;4288.721233119837;4336.262835318003;4342.609165175149;4348.043430445297;4406.140802543538;4498.437695288089;4514.7291162530355;4517.932231016537;4521.186186486464;4573.771311434415;4617.930731039104;4728.1962066448095;4728.361671174485;4728.668993170445;4780.689255198401;4949.678270912379;4970.701757894538;5002.174641184164;5024.974875125601;5025;4704.929426058543;4709.623230141512;4727.409073865767;4754.23932170851;4828.855134345975;4994.200927851526;5000.099982003128;5005.774740136775;5058.671186373022;5058.721770302522;5027.974860125676;5036.445990940921;5041.495850414929;5045.445001049955;5103.7448127592725;4752.952470475251;4816.084943860656;4897.583705385082;4936.58039066669;5006.148954677787;4914.410270767531;4958.677685950546;4960.826371076995;5018.272350509083;5028.170351891897;4793.592544633745;4877.3903262092235;4893.119238537098;4894.559489645949;4942.1598328285;4823.831165909317;4877.048975449753;5010.749462526932;5020.723860187724;5075.670081444694;4809.350737650372;4812.807487700453;4863.878403039811;4880.267959806058;4933.925991110064 22:51:19 INFO - PROCESS | 11850 | |1;ext.html;559.0272925110307;570.9600327977043;573.6758731316809;579.0098930828286;588.655636452675;27401;38432.80783596082;39143.41284880729;39231.80384098079;43024.3546346805;39453.8027309863;39833;39954.40068398976;39977.80011099948;39990.60009399905;7557.773266801991;7758.806029849243;7765.650545725428;7767.378609711238;7776.3778897688335;7554.50895691781;7622.618869056525;7634.045744281965;7638.197989211136;7640.5797681127515;7665.731699390522;7706.460547761659;7712.1902200269005;7714.922850771477;7716.9614151929445;7592.126905405894;7600.201978792258;7623.275788800055;7651.349635281008;7659.119201291867;7599.012128423325;7662.616869156575;7662.65518051689;7663.195364486704;7665.808354791119;36249.637503625156;36613;36618.8169059153;36650.45024324637;36681;2958.7632989361014;3003.429348423814;3036.7722420818527;3276.311974485361;3289.5723555937575;29088.41823163525;29143.85428072846;29160.416791664262;29709.40581188364;31024.844875775703;3310.5034244863223;3313.950290745641;3480.6867381935494;3516.613172551017;3543.6102028776813;239951;242113;243021;243109;243989;31787.84106079501;32300.35399292001;32375.838120809247;53621.46378536243;54310;33441.163970900925;33823;33843.32313353719;33864.49203261953;33868.1532961673;13095;13212.405441755143;13213.73572528544;13227.074104812764;13228.867711322957;10923.289986150874;10961.56153753841;11029.724256893642;11034.172437067253;11034.944825275983;7734.57459839703;7782.105057918298;7793.142754297023;7883.802904927308;7892.9210707893335;3069.2020074780717;3070.585470961392;3078.7383072439093;3080.383923215366;3086.182161727144;870.5951732444444;899.1458114790844;900.0009988912302;900.1898291537537;920.3787443475627;26474.867625661747;28160.43679126447;28295.29261768472;29251.414971700447;29823.403531929675;737.5611511150856;941.3645789092335;964.0937518732369;976.4336684722844;979.6620166042704;13936.790948135786;14512.274386280644;14632.122072675673;14774.113553186628;14858.479953201802;349363;352817;353094;353387;354398;49936.500634993914;50112.24831627528;50426.49573504218;50494.24258636124;50522;1074.8763892152347;1122.0798944865132;1167.200467679642;1175.988240117605;1226.6136167107334;25223;29184.854075729487;29323;29456.400049757434;29470.852645736635;41969.79015104905;42629.57370426256;42728.35907461453;42751.358729618456;42779.57220427756;287529;290387;290419;290590;290998;24467.021319147036;25289.747102528738;25334.1133060342;25374;25384.365390865376;41382.172356552095;41896.790516048444;42144.36783448312;42392.36411453893;43350.78324608357;35148.472772908935;35658.82170589131;35942.8202858984;36076.81961590175;36345.636543634224;35527.46708799319;35718.28563428665;35853.10367240736;36039;36244.09389765277;34384;34500.705408464026;35414.468782967764;35438;35659.28681426409;30210.69789302167;33143;33163.83418082894;33298;33308.833455833534;24434.389140271636;25008.249752507454;25185.49629007446;25196.75596264234;25380.492390152463 22:51:19 INFO - PROCESS | 11850 | |2;jquery.html;342.9437333014316;357.40135273417036;366.61505419309725;374.4551677309514;379.2282704695944;12205.694857628563;12923.483060677574;13545.796813047813;16400.75398869018;16402.83597164028;15810.209489525536;16070.59823504413;16438.67122657546;16555.91722041391;16560.420385286518;4931.038447502739;5151.562117220041;5157.252198431225;5157.30376399185;5158.742062896859;3652.141746689526;3791.9810400948095;5655.8586035349035;5898.321693005317;5957.434043765836;5673.602847800656;5987.22166118404;6007.8197654070445;6018.037114061751;6024;5842.386549412315;5872.882542349129;5989.940100598982;6042.818715438544;6053.636781793107;4656.883577910546;4958.181899986498;5303.4696530346655;5303.867403314909;5304.708241046741;11912.927836494757;12038.69903252417;19201.80798192014;19226.423207303662;19693.704594431096;1784.304121392645;1939.6314700207056;2187.0704950396016;2302.976970230293;2375.714914210306;8380.916190838074;8538.44500107491;8586.656533738644;8861.335399844973;9221.400608960463;1625.9512614363787;1700.2263969893668;1727.4385824607052;1734.1156010434643;1749.527627540557;62763.686181569254;67753.3224667752;67870.66064669644;68889.65555172192;68984;9518.428894266228;9528.523573821281;9544.713658590254;9786.902130978599;9799.314048016571;13592.592222233348;13612.86387136116;13618.659533511742;13631.522896698569;13642.863571364358;6958.547694399847;7191.64041797908;7267.200607933123;7350.889736653954;7392.741254056083;6741.662916854138;6745.3591908768585;6845.14435695538;6925.930740692629;7005.754798582026;4108.67130629549;4140.399642051946;4149.543550209474;4197.118605092965;4215.220184265921;1661.127907848365;1743.8256174382461;1774.3346245158066;1775.7869055713138;1782.393986044751;650.7722297195944;749.8987636669088;783.4280974888363;786.1470304719329;792.4888446951684;15641.60895977587;15886.52340429789;16276.186190690654;16314.102724350274;16784.832151678573;769.9345555627834;785.7917651822272;795.6181033104142;819.2836008562053;844.5523872347543;8756.124387561193;8947.821043579092;9205.723828285161;9279.582418791171;9396.71809845692;158697;161703;349981;352058;352394;71138.28861711317;72305;80735.19264807395;81828.95427614238;81872;887.9422837515541;895.8566629339274;930.1024511346583;931.8602209668468;932.2029664636638;15148.469803556822;15259.694806104038;15934;15992.520224393287;16258.268377922785;26687.866560667073;36746;37137.442938356486;37578.812105939294;37780.43329350117;50983.49016509787;51924;52018.73990630022;52787.472125278255;54908.17637735517;7332.890006649798;7467.215942325977;7500.699972001059;7602;7686.3850891927395;9775.266854986046;11334;11589.710257243636;11814.409279535817;11895.583654572049;9290.442573445614;9527.475988820404;9815.803683926424;10061.245406594388;10106.696799096038;9697.9030209697;9715.125638692552;9727.270454716067;9836.950815245878;9985.350952188084;9614.95192524033;9640;9992.700218993441;10282;10552.525136368728;7293.088363954505;7557.395408367427;7596.392288617008;7647.923520764721;7945.8410831781885;9382.48396338208;9445.52772361393;9517.669460395642;9894.653687120915;9922.503874806374 22:51:19 INFO - PROCESS | 11850 | |3;mootools.html;1336.0313772514926;1371.3623165228166;1411.442480220313;1601.4394961763392;1634.8528632423072;6634.237062737787;6870.587764734107;7075.46933979951;7685.846283074342;7701.92298077019;7404.4816862819625;7722.382209423246;7722.536647801136;7741.49680270782;7751.844963100734;2122.8089471947524;2141.100737690166;2155.4719093822036;2159.5788821179876;2162.156758864044;1793.9641207175914;1846.1876774219368;2022.0294258755805;2084.3017589107667;2109.789021097886;2074.647309957311;2099.4436474334316;2101.338078505266;2116.7036614873855;2120.204923153817;2036.3483685220735;2041.3263623004373;2042.2443695832562;2050.507878109258;2077.4598604362973;2002.5294055896852;2004.0681083296338;2007.2673474181966;2008.0863207240816;2011.3965810256864;7545.660445279976;7547.811304717371;7582.772516824449;7605.201453847321;7654.808629784245;4268.445102136702;4377.23398405281;4381.38660587518;4401.933970990406;4405.889852753675;2650.2314328844614;2656.375751698349;2757.3382388226883;2772.279207406069;2777.402858385457;896.0546623312403;901.6708901250996;907.7594437474074;1703.8296170382987;1778.2797966823457;10256.538455769509;10283.560301557787;10345.431001294926;10380.688579342708;10393.376397416103;3758.699304055669;3759.586445490994;3902.512185976753;3906.628870257378;3913.5108111486065;7986.7603971880935;7991.800204994805;7998.680052797939;8003.4797738146835;8007.559584222807;4322.805473753689;4323.870283891489;4327.6105150536605;4327.675424343124;4330.480342358937;4005.819738111792;4018.3972404139613;4027.859024934113;4028.456158418576;4030.6976976726864;3313;3406.5741782277214;3411.914702132417;3425.3663072331697;3495.213576945167;975.687779910436;980.9362391444533;1025.661531694539;1045.3675526306627;1052.2055847834836;664.3389827122045;759.9924000760033;808.8058865872266;811.5090370325986;856.6230858422274;5004.424491183488;5134.743262836918;5157.690538567698;5324.547413469821;5416.458354164631;849.2017503546647;885.6634478897978;891.7012800711834;897.156672727647;900.4732231644562;3570.589382221078;3655.0314166745834;3659.323025240339;3673.1184515716036;3920.17676287977;8964.506952117566;9482.051794820463;9524.952375238217;9555.952220238854;9558.808823823485;9388.95305523468;9421.199198068241;9426.434413935185;9426.95286523563;9438.764030899283;6794.932050679528;6976.651167441608;7017.193022802443;7210.1708303545765;7213.170485394142;5254.6847189168775;5383.973080134731;5460.808871689472;5493.7802487900035;5754;8133.918660813553;8238;8612.526311052701;8654.740357789276;8664;8195.46729462583;8635.481871087755;8845.601947912488;8927.062658420773;8936.821263574562;7183.497155199295;7424.591647459441;7425.8143546411775;7428.814279643052;7430.7027718892805;7363.705451781869;7417.369523590555;7429.777106686808;7436.405087593088;7445.032145821226;6413.038044293206;6599.274079851309;6671.5997040177745;6688.230853451915;6783.287754785873;6548.639824809681;6559;6562.146920900253;6633.6019838809825;6730.764423245163;6041.456268935817;6162;6190.938090619036;6223.782167624111;6232.75068997235;4489.573490518395;4551.203539380529;4650.651201159859;4660.184467718203;4830.661853670209;4429.357743127293;4598.655100867381;4600.42494688164;4602.493725690105;4650.4186976627925 22:51:19 INFO - PROCESS | 11850 | |4;prototype.html;266.3434633628106;283.63552834607526;286.3357011732781;287.7395956659224;292.2299740184613;4569.908601827961;4826.638002149835;4828.275758636207;4863.294822250771;4869.902601947959;4577.725336479805;4741.90516189676;4786.521347865212;4806.567408933195;4894.119058569456;3563.4476656118213;3675.191457879262;3770.2836461072307;3772.886813395589;3787.4508196311517;3640.3447379471686;3743.582572564373;3764.6047165047685;3770.396736522157;3787.541796408389;3727.3104475671953;3744.2511497700434;3744.681702055315;3746.4567637692517;3768.8492460301554;3749.8312575934146;3757.2485502899394;3763.9435408468894;3779.6787273081545;3780.489633899416;3251.577294951665;3305.074579117851;3330.5004249362546;3337.1156643489494;3352.379809735207;4645.256758918556;4658.161530924433;4658.86023419298;4669.486356500782;4685.4377474702915;4238.809253583596;4266.488021437447;4270.416398079148;4276.3799249109015;4278.994436307466;4825.565699087064;5005.34930459038;5031.949680503221;5032.748362581893;5039.974800126012;3531.1525233943667;3536.3634545781747;3537.823108844573;3543.6102028776813;3553.5380400547765;5262.05283049051;5279.340082489689;5309.469053094698;5314.7608357624;5323.85892323531;3475.461303497962;3541.4974342717665;3597.546355498698;3637.1452708613456;3666.7249956253386;3676.371394452979;3676.5036720042986;3679.1721862580707;3680.8773324136396;3690.4833323334756;4217.978910105491;4253.298205796009;4261.87214383569;4283.507396649363;4285.142971405731;4805.183118869801;4880.6095512358925;4948.183549714328;5015.749212539431;5077.466865979093;1248.5329737558332;1261.2180448122224;1263.879931406515;1270.39021269791;1272.9498164014724;772.3820943245381;787.8463699578642;802.3340627279345;803.1648281566081;820.335528222142;4041.191761647682;4041.2927737645796;4068.7965601719798;4079.5925405734974;4086.693497987603;4512.3908272382805;4579.793909274091;4601.930971035437;4614.031053478807;4644.698094623838;3995.3430968406265;4023.91952160961;4040.9797951010055;4048.8987775305263;4059.573744756817;2268.8298377621745;2416.5046165536023;2430.283066495388;2452.5217582571227;2463.2733343663663;4323.502797178302;4323.654107671378;4337.327714204241;4373.431453910971;4383.715058521186;4655.348251244828;4674.205385084544;4719.955628619521;4727.912580106595;4739.620830333565;4093.6841158661578;4310.7929779661745;4335.9187589957;4336.848210312624;4337.934930976038;4565.429321334833;4578.771061446981;4585.518520555293;4591.977040114778;4595.632349412106;4497.595216430537;4509.481409637933;4522.660800439914;4524.054656497738;4543.295789152687;3992.9001774954695;4287.935680964725;4351.259496201418;4354.281543545279;4366.563343665608;3328.450805617046;3333.4833100869405;3335.8332083396217;3348.4977253412185;3395.5076513905838;4600.3329517219145;4603.470600880942;4681.976590117028;4693.108309421199;5008.3238762768015;4945.604351651931;5037.236967061499;5068.670536415121;5069.163588008085;5112.335396398445;4998.525140111684;5013.974930125326;5038.269450929522;5039.521245481674;5040.656094915882;4811.446683631287;4974.651774375759;4994.625403094709;5001.449840517467;5041.269015992587;5112;5125.282460455614;5126.410462796677;5128.564072053917;5142.51146141116;5020.723860187724;5021.196608542616;5030.4718004608985;5036.571891389273;5054.823081192288 22:51:19 INFO - PROCESS | 11850 | |5;yui.html;610.9602875813073;708.9184743754466;717.7093277222723;730.7223255163037;736.5212611802327;12687.11190216684;13490.325483725823;13499.460021599125;13515.932420337896;13525.864741352596;11730.944215020647;13522.797158042613;13615.795763063563;13672.111312764688;13672.453101875913;731.2650785960116;733.7615275035608;739.4380270994029;739.5414842797474;741.5143081281769;754.3625636337287;754.9962250188742;755.8337165823538;756.058706909898;756.0813611462072;778.5250996891891;779.1585088104833;779.185750890321;779.668640827646;779.8323360477497;772.4554189296589;776.0764690018859;776.2547953964173;776.3362325211975;777.3276116159537;570.1647087017498;570.3583468597827;570.3982298674896;570.6547538739086;572.1246492865922;12107.515699372014;12238.877611223952;12275.570355037531;12281.508739650404;12283.508659653604;11014;11149.554017839358;11231.10151187903;11624.88375116255;11753;9428.952855235748;9471.47906865122;9813.754656133582;9845.753856153582;9914.504274786232;3188.984055079733;3203.8077715337154;3269.182704323919;3285.983570082158;3322.7840190387546;61483;63046.684766576334;63213.367866321205;63533;64683.67658161726;8565.27195188416;8777.824443511094;8801.823963520694;8848.292136629054;8861.822763544822;17306.48080557585;17308.826911730972;17317.134143292784;17317.22072506715;17337.65324693499;6666.300038495985;6672.199336079701;6777.762778302736;6954.374106330454;7067.82330441743;3671.706263498914;3730.8321125548873;3740.5511338638994;3746.38184699527;3760.2479504099288;2799.202227365191;2892.7251911068415;2905.956410653842;2909.418116376733;2915.5772412999995;486.8442098528508;487.10372913838705;490.36742602043677;490.41395532339226;494.2956287290597;516.8681986093522;585.745200837637;626.139058794158;659.8911179655303;661.8979399300111;7711.332170854417;8165.387595930329;8565.785855353666;8667.739967800977;8865.423747456394;619.1548536248079;629.8425393651587;640.8013515810114;642.5534253693731;648.4909346163239;3926.9018274542796;4095.692823038284;4205.74765514064;4385.276429389115;4407.801648925806;73431.63284183545;76974.615126924;77089.614551928;88413.55793220992;98055;76899;78291;78815;81051.18948810437;81483;67723;67830;68974;69382.3061769386;70360;8572.614232359434;9104.544772761468;9159.725208243763;9168.908310916806;9243.491607961358;40799.79600101981;41322;41985;42311.153776923675;42585.78707106445;58408.70795645995;60500;62840.371596283454;65900;66843.66578167077;11170.832437513607;11579.305241685526;12103;12295.815562766387;12866.935665321613;12889.09776315649;13384.93307533456;13571.728565428833;13835.155802425843;14347.067440616327;12440.75118497643;12687.81302170275;12765.170263932814;12765.297908614744;13498.392572334466;11105.333679978903;12510.562130325396;12813.423395947018;12879.871201287868;13613.727725445633;11965.222260553037;12108.576199832964;12290.75418491643;12317.384130793245;12644.683882903;9392.20166285846;9395.24838012971;9599.616015359587;9945.602175912882;10045.246606504688;10862.674119776419;10970.890291096986;11119;11156.24532162303;11332.036776874058 22:51:19 INFO - PROCESS | 11850 | __end_tp_report 22:51:19 INFO - PROCESS | 11850 | __start_cc_report 22:51:19 INFO - PROCESS | 11850 | _x_x_mozilla_cycle_collect,1268 22:51:19 INFO - PROCESS | 11850 | __end_cc_report 22:51:19 INFO - PROCESS | 11850 | __startTimestamp1475905879179__endTimestamp 22:51:19 INFO - PROCESS | 11850 | 22:51:19 INFO - PROCESS | 11850 | ------- Summary: start ------- 22:51:19 INFO - PROCESS | 11850 | Number of tests: 6 22:51:19 INFO - PROCESS | 11850 | 22:51:19 INFO - PROCESS | 11850 | [#0] dojo.html Cycles:165 Average:4665.47 Median:4780.69 stddev:483.95 (10.1%) stddev-sans-first:456.90 22:51:19 INFO - PROCESS | 11850 | Values: 2578.6 2612.9 2657.8 2658.1 2670.2 4556.3 4645.3 4723.5 4771.6 4844.5 4673.0 4674.0 4682.2 4684.8 4693.7 4282.8 4299.1 4305.5 4315.3 4325.4 4321.3 4359.5 4409.6 4433.1 4446.2 4446.7 4459.2 4460.1 4515.5 4516.1 4309.3 4401.8 4483.9 4485.5 4487.7 4224.6 4397.4 4406.8 4429.2 4446.0 4625.2 4666.8 4693.2 4693.9 4721.4 4969.1 4970.5 4974.4 4991.8 5058.8 5034.9 5073.4 5086.0 5087.8 5120.7 4523.1 4563.3 4677.7 4721.9 4786.0 5154.1 5195.9 5199.1 5202.6 5254.8 4982.5 4993.9 4994.0 4995.5 5057.1 4836.4 4905.2 4974.0 5031.0 5071.3 4991.3 4994.3 5018.2 5054.2 5056.7 4961.4 4975.2 4978.0 4978.2 5034.1 4156.9 4202.1 4207.2 4252.3 4253.8 3682.9 3728.0 3733.3 3735.8 3806.4 4390.0 4391.5 4401.6 4439.1 4449.9 4887.3 4958.5 5086.6 5107.4 5108.4 4288.7 4336.3 4342.6 4348.0 4406.1 4498.4 4514.7 4517.9 4521.2 4573.8 4617.9 4728.2 4728.4 4728.7 4780.7 4949.7 4970.7 5002.2 5025.0 5025.0 4704.9 4709.6 4727.4 4754.2 4828.9 4994.2 5000.1 5005.8 5058.7 5058.7 5028.0 5036.4 5041.5 5045.4 5103.7 4753.0 4816.1 4897.6 4936.6 5006.1 4914.4 4958.7 4960.8 5018.3 5028.2 4793.6 4877.4 4893.1 4894.6 4942.2 4823.8 4877.0 5010.7 5020.7 5075.7 4809.4 4812.8 4863.9 4880.3 4933.9 22:51:19 INFO - PROCESS | 11850 | 22:51:19 INFO - PROCESS | 11850 | [#1] ext.html Cycles:180 Average:43968.38 Median:19479.04 stddev:78488.93 (402.9%) stddev-sans-first:78641.44 22:51:19 INFO - PROCESS | 11850 | Values: 559.0 571.0 573.7 579.0 588.7 27401.0 38432.8 39143.4 39231.8 43024.4 39453.8 39833.0 39954.4 39977.8 39990.6 7557.8 7758.8 7765.7 7767.4 7776.4 7554.5 7622.6 7634.0 7638.2 7640.6 7665.7 7706.5 7712.2 7714.9 7717.0 7592.1 7600.2 7623.3 7651.3 7659.1 7599.0 7662.6 7662.7 7663.2 7665.8 36249.6 36613.0 36618.8 36650.5 36681.0 2958.8 3003.4 3036.8 3276.3 3289.6 29088.4 29143.9 29160.4 29709.4 31024.8 3310.5 3314.0 3480.7 3516.6 3543.6 239951.0 242113.0 243021.0 243109.0 243989.0 31787.8 32300.4 32375.8 53621.5 54310.0 33441.2 33823.0 33843.3 33864.5 33868.2 13095.0 13212.4 13213.7 13227.1 13228.9 10923.3 10961.6 11029.7 11034.2 11034.9 7734.6 7782.1 7793.1 7883.8 7892.9 3069.2 3070.6 3078.7 3080.4 3086.2 870.6 899.1 900.0 900.2 920.4 26474.9 28160.4 28295.3 29251.4 29823.4 737.6 941.4 964.1 976.4 979.7 13936.8 14512.3 14632.1 14774.1 14858.5 349363.0 352817.0 353094.0 353387.0 354398.0 49936.5 50112.2 50426.5 50494.2 50522.0 1074.9 1122.1 1167.2 1176.0 1226.6 25223.0 29184.9 29323.0 29456.4 29470.9 41969.8 42629.6 42728.4 42751.4 42779.6 287529.0 290387.0 290419.0 290590.0 290998.0 24467.0 25289.7 25334.1 25374.0 25384.4 41382.2 41896.8 42144.4 42392.4 43350.8 35148.5 35658.8 35942.8 36076.8 36345.6 35527.5 35718.3 35853.1 36039.0 36244.1 34384.0 34500.7 35414.5 35438.0 35659.3 30210.7 33143.0 33163.8 33298.0 33308.8 24434.4 25008.2 25185.5 25196.8 25380.5 22:51:19 INFO - PROCESS | 11850 | 22:51:19 INFO - PROCESS | 11850 | [#2] jquery.html Cycles:180 Average:20746.32 Median:5664.73 stddev:49037.72 (865.7%) stddev-sans-first:49151.36 22:51:19 INFO - PROCESS | 11850 | Values: 342.9 357.4 366.6 374.5 379.2 12205.7 12923.5 13545.8 16400.8 16402.8 15810.2 16070.6 16438.7 16555.9 16560.4 4931.0 5151.6 5157.3 5157.3 5158.7 3652.1 3792.0 5655.9 5898.3 5957.4 5673.6 5987.2 6007.8 6018.0 6024.0 5842.4 5872.9 5989.9 6042.8 6053.6 4656.9 4958.2 5303.5 5303.9 5304.7 11912.9 12038.7 19201.8 19226.4 19693.7 1784.3 1939.6 2187.1 2303.0 2375.7 8380.9 8538.4 8586.7 8861.3 9221.4 1626.0 1700.2 1727.4 1734.1 1749.5 62763.7 67753.3 67870.7 68889.7 68984.0 9518.4 9528.5 9544.7 9786.9 9799.3 13592.6 13612.9 13618.7 13631.5 13642.9 6958.5 7191.6 7267.2 7350.9 7392.7 6741.7 6745.4 6845.1 6925.9 7005.8 4108.7 4140.4 4149.5 4197.1 4215.2 1661.1 1743.8 1774.3 1775.8 1782.4 650.8 749.9 783.4 786.1 792.5 15641.6 15886.5 16276.2 16314.1 16784.8 769.9 785.8 795.6 819.3 844.6 8756.1 8947.8 9205.7 9279.6 9396.7 158697.0 161703.0 349981.0 352058.0 352394.0 71138.3 72305.0 80735.2 81829.0 81872.0 887.9 895.9 930.1 931.9 932.2 15148.5 15259.7 15934.0 15992.5 16258.3 26687.9 36746.0 37137.4 37578.8 37780.4 50983.5 51924.0 52018.7 52787.5 54908.2 7332.9 7467.2 7500.7 7602.0 7686.4 9775.3 11334.0 11589.7 11814.4 11895.6 9290.4 9527.5 9815.8 10061.2 10106.7 9697.9 9715.1 9727.3 9837.0 9985.4 9615.0 9640.0 9992.7 10282.0 10552.5 7293.1 7557.4 7596.4 7647.9 7945.8 9382.5 9445.5 9517.7 9894.7 9922.5 22:51:19 INFO - PROCESS | 11850 | 22:51:19 INFO - PROCESS | 11850 | [#3] mootools.html Cycles:180 Average:4999.54 Median:5400.22 stddev:2784.54 (51.6%) stddev-sans-first:2778.74 22:51:19 INFO - PROCESS | 11850 | Values: 1336.0 1371.4 1411.4 1601.4 1634.9 6634.2 6870.6 7075.5 7685.8 7701.9 7404.5 7722.4 7722.5 7741.5 7751.8 2122.8 2141.1 2155.5 2159.6 2162.2 1794.0 1846.2 2022.0 2084.3 2109.8 2074.6 2099.4 2101.3 2116.7 2120.2 2036.3 2041.3 2042.2 2050.5 2077.5 2002.5 2004.1 2007.3 2008.1 2011.4 7545.7 7547.8 7582.8 7605.2 7654.8 4268.4 4377.2 4381.4 4401.9 4405.9 2650.2 2656.4 2757.3 2772.3 2777.4 896.1 901.7 907.8 1703.8 1778.3 10256.5 10283.6 10345.4 10380.7 10393.4 3758.7 3759.6 3902.5 3906.6 3913.5 7986.8 7991.8 7998.7 8003.5 8007.6 4322.8 4323.9 4327.6 4327.7 4330.5 4005.8 4018.4 4027.9 4028.5 4030.7 3313.0 3406.6 3411.9 3425.4 3495.2 975.7 980.9 1025.7 1045.4 1052.2 664.3 760.0 808.8 811.5 856.6 5004.4 5134.7 5157.7 5324.5 5416.5 849.2 885.7 891.7 897.2 900.5 3570.6 3655.0 3659.3 3673.1 3920.2 8964.5 9482.1 9525.0 9556.0 9558.8 9389.0 9421.2 9426.4 9427.0 9438.8 6794.9 6976.7 7017.2 7210.2 7213.2 5254.7 5384.0 5460.8 5493.8 5754.0 8133.9 8238.0 8612.5 8654.7 8664.0 8195.5 8635.5 8845.6 8927.1 8936.8 7183.5 7424.6 7425.8 7428.8 7430.7 7363.7 7417.4 7429.8 7436.4 7445.0 6413.0 6599.3 6671.6 6688.2 6783.3 6548.6 6559.0 6562.1 6633.6 6730.8 6041.5 6162.0 6190.9 6223.8 6232.8 4489.6 4551.2 4650.7 4660.2 4830.7 4429.4 4598.7 4600.4 4602.5 4650.4 22:51:19 INFO - PROCESS | 11850 | 22:51:19 INFO - PROCESS | 11850 | [#4] prototype.html Cycles:180 Average:4013.07 Median:4352.77 stddev:1168.42 (26.8%) stddev-sans-first:1137.35 22:51:19 INFO - PROCESS | 11850 | Values: 266.3 283.6 286.3 287.7 292.2 4569.9 4826.6 4828.3 4863.3 4869.9 4577.7 4741.9 4786.5 4806.6 4894.1 3563.4 3675.2 3770.3 3772.9 3787.5 3640.3 3743.6 3764.6 3770.4 3787.5 3727.3 3744.3 3744.7 3746.5 3768.8 3749.8 3757.2 3763.9 3779.7 3780.5 3251.6 3305.1 3330.5 3337.1 3352.4 4645.3 4658.2 4658.9 4669.5 4685.4 4238.8 4266.5 4270.4 4276.4 4279.0 4825.6 5005.3 5031.9 5032.7 5040.0 3531.2 3536.4 3537.8 3543.6 3553.5 5262.1 5279.3 5309.5 5314.8 5323.9 3475.5 3541.5 3597.5 3637.1 3666.7 3676.4 3676.5 3679.2 3680.9 3690.5 4218.0 4253.3 4261.9 4283.5 4285.1 4805.2 4880.6 4948.2 5015.7 5077.5 1248.5 1261.2 1263.9 1270.4 1272.9 772.4 787.8 802.3 803.2 820.3 4041.2 4041.3 4068.8 4079.6 4086.7 4512.4 4579.8 4601.9 4614.0 4644.7 3995.3 4023.9 4041.0 4048.9 4059.6 2268.8 2416.5 2430.3 2452.5 2463.3 4323.5 4323.7 4337.3 4373.4 4383.7 4655.3 4674.2 4720.0 4727.9 4739.6 4093.7 4310.8 4335.9 4336.8 4337.9 4565.4 4578.8 4585.5 4592.0 4595.6 4497.6 4509.5 4522.7 4524.1 4543.3 3992.9 4287.9 4351.3 4354.3 4366.6 3328.5 3333.5 3335.8 3348.5 3395.5 4600.3 4603.5 4682.0 4693.1 5008.3 4945.6 5037.2 5068.7 5069.2 5112.3 4998.5 5014.0 5038.3 5039.5 5040.7 4811.4 4974.7 4994.6 5001.4 5041.3 5112.0 5125.3 5126.4 5128.6 5142.5 5020.7 5021.2 5030.5 5036.6 5054.8 22:51:19 INFO - PROCESS | 11850 | 22:51:19 INFO - PROCESS | 11850 | [#5] yui.html Cycles:180 Average:17035.07 Median:571.39 stddev:23406.00 (4096.3%) stddev-sans-first:23439.17 22:51:19 INFO - PROCESS | 11850 | Values: 611.0 708.9 717.7 730.7 736.5 12687.1 13490.3 13499.5 13515.9 13525.9 11730.9 13522.8 13615.8 13672.1 13672.5 731.3 733.8 739.4 739.5 741.5 754.4 755.0 755.8 756.1 756.1 778.5 779.2 779.2 779.7 779.8 772.5 776.1 776.3 776.3 777.3 570.2 570.4 570.4 570.7 572.1 12107.5 12238.9 12275.6 12281.5 12283.5 11014.0 11149.6 11231.1 11624.9 11753.0 9429.0 9471.5 9813.8 9845.8 9914.5 3189.0 3203.8 3269.2 3286.0 3322.8 61483.0 63046.7 63213.4 63533.0 64683.7 8565.3 8777.8 8801.8 8848.3 8861.8 17306.5 17308.8 17317.1 17317.2 17337.7 6666.3 6672.2 6777.8 6954.4 7067.8 3671.7 3730.8 3740.6 3746.4 3760.2 2799.2 2892.7 2906.0 2909.4 2915.6 486.8 487.1 490.4 490.4 494.3 516.9 585.7 626.1 659.9 661.9 7711.3 8165.4 8565.8 8667.7 8865.4 619.2 629.8 640.8 642.6 648.5 3926.9 4095.7 4205.7 4385.3 4407.8 73431.6 76974.6 77089.6 88413.6 98055.0 76899.0 78291.0 78815.0 81051.2 81483.0 67723.0 67830.0 68974.0 69382.3 70360.0 8572.6 9104.5 9159.7 9168.9 9243.5 40799.8 41322.0 41985.0 42311.2 42585.8 58408.7 60500.0 62840.4 65900.0 66843.7 11170.8 11579.3 12103.0 12295.8 12866.9 12889.1 13384.9 13571.7 13835.2 14347.1 12440.8 12687.8 12765.2 12765.3 13498.4 11105.3 12510.6 12813.4 12879.9 13613.7 11965.2 12108.6 12290.8 12317.4 12644.7 9392.2 9395.2 9599.6 9945.6 10045.2 10862.7 10970.9 11119.0 11156.2 11332.0 22:51:19 INFO - PROCESS | 11850 | -------- Summary: end -------- 22:51:19 INFO - PROCESS | 11850 | 22:51:20 INFO - TEST-INFO | 11850: exit 0 22:51:20 INFO - TEST-OK | dromaeo_css | took 1122184ms 22:51:20 INFO - TEST-START | kraken 22:51:20 INFO - operating with platform_type : linux_ 22:51:20 INFO - Initialising browser for kraken test... 22:51:20 INFO - TEST-INFO | started process 12154 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv8aGrF/profile http://localhost:47908/getInfo.html) 22:51:24 INFO - PROCESS | 12154 | __metrics Screen width/height:1600/1200 22:51:24 INFO - PROCESS | 12154 | colorDepth:24 22:51:24 INFO - PROCESS | 12154 | Browser inner width/height: 1024/697 22:51:24 INFO - PROCESS | 12154 | __metrics 22:51:25 INFO - PROCESS | 12154 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:51:25 INFO - PROCESS | 12154 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:51:25 INFO - PROCESS | 12154 | console.error: PushService: 22:51:25 INFO - PROCESS | 12154 | stateChangeProcessEnqueue: Error transitioning state 22:51:25 INFO - PROCESS | 12154 | UnknownError 22:51:26 INFO - TEST-INFO | 12154: exit 0 22:51:26 INFO - Browser initialized. 22:51:26 INFO - Running cycle 1/1 for kraken test... 22:51:26 INFO - TEST-INFO | started process 12236 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv8aGrF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:51:38 INFO - PROCESS | 12236 | RSS: Main: 174678016 22:51:38 INFO - PROCESS | 12236 | 22:51:41 INFO - PROCESS | 12236 | Cycle 1(1): loaded http://localhost:47908/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47908/tests/kraken/driver.html?testName=audio-beat-detection) 22:51:42 INFO - PROCESS | 12236 | RSS: Main: 237129728 22:51:42 INFO - PROCESS | 12236 | 22:51:45 INFO - PROCESS | 12236 | Cycle 1(1): loaded http://localhost:47908/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47908/tests/kraken/driver.html?testName=audio-dft) 22:51:45 INFO - PROCESS | 12236 | RSS: Main: 217976832 22:51:45 INFO - PROCESS | 12236 | 22:51:49 INFO - PROCESS | 12236 | Cycle 1(1): loaded http://localhost:47908/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47908/tests/kraken/driver.html?testName=audio-fft) 22:51:49 INFO - PROCESS | 12236 | RSS: Main: 300302336 22:51:49 INFO - PROCESS | 12236 | 22:51:51 INFO - PROCESS | 12236 | Cycle 1(1): loaded http://localhost:47908/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47908/tests/kraken/driver.html?testName=audio-oscillator) 22:51:52 INFO - PROCESS | 12236 | RSS: Main: 211357696 22:51:52 INFO - PROCESS | 12236 | 22:51:54 INFO - PROCESS | 12236 | Cycle 1(1): loaded http://localhost:47908/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47908/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:51:55 INFO - PROCESS | 12236 | RSS: Main: 214163456 22:51:55 INFO - PROCESS | 12236 | 22:51:58 INFO - PROCESS | 12236 | Cycle 1(1): loaded http://localhost:47908/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47908/tests/kraken/driver.html?testName=imaging-darkroom) 22:51:59 INFO - PROCESS | 12236 | RSS: Main: 249774080 22:51:59 INFO - PROCESS | 12236 | 22:52:02 INFO - PROCESS | 12236 | Cycle 1(1): loaded http://localhost:47908/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47908/tests/kraken/driver.html?testName=imaging-desaturate) 22:52:03 INFO - PROCESS | 12236 | RSS: Main: 244154368 22:52:03 INFO - PROCESS | 12236 | 22:52:06 INFO - PROCESS | 12236 | Cycle 1(1): loaded http://localhost:47908/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47908/tests/kraken/driver.html?testName=json-parse-financial) 22:52:06 INFO - PROCESS | 12236 | RSS: Main: 246566912 22:52:06 INFO - PROCESS | 12236 | 22:52:08 INFO - PROCESS | 12236 | Cycle 1(1): loaded http://localhost:47908/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47908/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:52:09 INFO - PROCESS | 12236 | RSS: Main: 210309120 22:52:09 INFO - PROCESS | 12236 | 22:52:10 INFO - PROCESS | 12236 | Cycle 1(1): loaded http://localhost:47908/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47908/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:52:11 INFO - PROCESS | 12236 | RSS: Main: 216928256 22:52:11 INFO - PROCESS | 12236 | 22:52:13 INFO - PROCESS | 12236 | Cycle 1(1): loaded http://localhost:47908/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47908/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:52:14 INFO - PROCESS | 12236 | RSS: Main: 226422784 22:52:14 INFO - PROCESS | 12236 | 22:52:17 INFO - PROCESS | 12236 | Cycle 1(1): loaded http://localhost:47908/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47908/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:52:17 INFO - PROCESS | 12236 | RSS: Main: 234938368 22:52:17 INFO - PROCESS | 12236 | 22:52:20 INFO - PROCESS | 12236 | Cycle 1(1): loaded http://localhost:47908/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47908/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:52:21 INFO - PROCESS | 12236 | RSS: Main: 232439808 22:52:21 INFO - PROCESS | 12236 | 22:52:23 INFO - PROCESS | 12236 | Cycle 1(1): loaded http://localhost:47908/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47908/tests/kraken/driver.html?testName=ai-astar) 22:52:23 INFO - PROCESS | 12236 | RSS: Main: 281092096 22:52:23 INFO - PROCESS | 12236 | 22:52:23 INFO - PROCESS | 12236 | __start_tp_report 22:52:23 INFO - PROCESS | 12236 | _x_x_mozilla_page_load 22:52:23 INFO - PROCESS | 12236 | _x_x_mozilla_page_load_details 22:52:23 INFO - PROCESS | 12236 | |i|pagename|runs| 22:52:23 INFO - PROCESS | 12236 | |0;ai-astar;111;117;115;114;114;115;117;114;115;114 22:52:23 INFO - PROCESS | 12236 | |1;audio-beat-detection;150;132;127;166;130;132;127;128;161;128 22:52:23 INFO - PROCESS | 12236 | |2;audio-dft;160;160;162;162;162;162;163;161;164;164 22:52:23 INFO - PROCESS | 12236 | |3;audio-fft;76;76;75;111;78;77;76;76;98;76 22:52:23 INFO - PROCESS | 12236 | |4;audio-oscillator;83;84;112;82;83;83;117;83;82;113 22:52:23 INFO - PROCESS | 12236 | |5;imaging-gaussian-blur;117;117;117;117;117;117;118;117;117;117 22:52:23 INFO - PROCESS | 12236 | |6;imaging-darkroom;147;147;148;147;147;147;148;147;148;147 22:52:23 INFO - PROCESS | 12236 | |7;imaging-desaturate;96;95;95;95;96;96;96;95;95;94 22:52:23 INFO - PROCESS | 12236 | |8;json-parse-financial;66;64;65;64;65;68;66;65;65;65 22:52:23 INFO - PROCESS | 12236 | |9;json-stringify-tinderbox;65;65;66;65;66;65;66;66;66;66 22:52:23 INFO - PROCESS | 12236 | |10;stanford-crypto-aes;83;84;84;82;83;83;84;83;83;82 22:52:23 INFO - PROCESS | 12236 | |11;stanford-crypto-ccm;138;140;137;137;137;142;136;137;181;139 22:52:23 INFO - PROCESS | 12236 | |12;stanford-crypto-pbkdf2;184;177;181;173;177;183;174;175;178;186 22:52:23 INFO - PROCESS | 12236 | |13;stanford-crypto-sha256-iterative;71;72;70;70;69;69;70;90;69;70 22:52:23 INFO - PROCESS | 12236 | __end_tp_report 22:52:23 INFO - PROCESS | 12236 | __start_cc_report 22:52:23 INFO - PROCESS | 12236 | _x_x_mozilla_cycle_collect,1957 22:52:23 INFO - PROCESS | 12236 | __end_cc_report 22:52:23 INFO - PROCESS | 12236 | __startTimestamp1475905943622__endTimestamp 22:52:23 INFO - PROCESS | 12236 | 22:52:23 INFO - PROCESS | 12236 | ------- Summary: start ------- 22:52:23 INFO - PROCESS | 12236 | Number of tests: 14 22:52:23 INFO - PROCESS | 12236 | 22:52:23 INFO - PROCESS | 12236 | [#0] ai-astar Cycles:10 Average:114.60 Median:115.00 stddev:1.71 (1.5%) stddev-sans-first:1.22 22:52:23 INFO - PROCESS | 12236 | Values: 111.0 117.0 115.0 114.0 114.0 115.0 117.0 114.0 115.0 114.0 22:52:23 INFO - PROCESS | 12236 | 22:52:23 INFO - PROCESS | 12236 | [#1] audio-beat-detection Cycles:10 Average:138.10 Median:132.00 stddev:15.04 (11.4%) stddev-sans-first:15.32 22:52:23 INFO - PROCESS | 12236 | Values: 150.0 132.0 127.0 166.0 130.0 132.0 127.0 128.0 161.0 128.0 22:52:23 INFO - PROCESS | 12236 | 22:52:23 INFO - PROCESS | 12236 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.41 (0.9%) stddev-sans-first:1.30 22:52:23 INFO - PROCESS | 12236 | Values: 160.0 160.0 162.0 162.0 162.0 162.0 163.0 161.0 164.0 164.0 22:52:23 INFO - PROCESS | 12236 | 22:52:23 INFO - PROCESS | 12236 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.00 stddev:12.32 (16.2%) stddev-sans-first:12.89 22:52:23 INFO - PROCESS | 12236 | Values: 76.0 76.0 75.0 111.0 78.0 77.0 76.0 76.0 98.0 76.0 22:52:23 INFO - PROCESS | 12236 | 22:52:23 INFO - PROCESS | 12236 | [#4] audio-oscillator Cycles:10 Average:92.20 Median:83.00 stddev:15.11 (18.2%) stddev-sans-first:15.65 22:52:23 INFO - PROCESS | 12236 | Values: 83.0 84.0 112.0 82.0 83.0 83.0 117.0 83.0 82.0 113.0 22:52:23 INFO - PROCESS | 12236 | 22:52:23 INFO - PROCESS | 12236 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 22:52:23 INFO - PROCESS | 12236 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 22:52:23 INFO - PROCESS | 12236 | 22:52:23 INFO - PROCESS | 12236 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 22:52:23 INFO - PROCESS | 12236 | Values: 147.0 147.0 148.0 147.0 147.0 147.0 148.0 147.0 148.0 147.0 22:52:23 INFO - PROCESS | 12236 | 22:52:23 INFO - PROCESS | 12236 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.50 stddev:0.67 (0.7%) stddev-sans-first:0.67 22:52:23 INFO - PROCESS | 12236 | Values: 96.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 95.0 94.0 22:52:23 INFO - PROCESS | 12236 | 22:52:23 INFO - PROCESS | 12236 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:65.00 stddev:1.16 (1.8%) stddev-sans-first:1.20 22:52:23 INFO - PROCESS | 12236 | Values: 66.0 64.0 65.0 64.0 65.0 68.0 66.0 65.0 65.0 65.0 22:52:23 INFO - PROCESS | 12236 | 22:52:23 INFO - PROCESS | 12236 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 22:52:23 INFO - PROCESS | 12236 | Values: 65.0 65.0 66.0 65.0 66.0 65.0 66.0 66.0 66.0 66.0 22:52:23 INFO - PROCESS | 12236 | 22:52:23 INFO - PROCESS | 12236 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:83.00 stddev:0.74 (0.9%) stddev-sans-first:0.78 22:52:23 INFO - PROCESS | 12236 | Values: 83.0 84.0 84.0 82.0 83.0 83.0 84.0 83.0 83.0 82.0 22:52:23 INFO - PROCESS | 12236 | 22:52:23 INFO - PROCESS | 12236 | [#11] stanford-crypto-ccm Cycles:10 Average:142.40 Median:138.50 stddev:13.68 (9.9%) stddev-sans-first:14.42 22:52:23 INFO - PROCESS | 12236 | Values: 138.0 140.0 137.0 137.0 137.0 142.0 136.0 137.0 181.0 139.0 22:52:23 INFO - PROCESS | 12236 | 22:52:23 INFO - PROCESS | 12236 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.80 Median:179.50 stddev:4.47 (2.5%) stddev-sans-first:4.32 22:52:23 INFO - PROCESS | 12236 | Values: 184.0 177.0 181.0 173.0 177.0 183.0 174.0 175.0 178.0 186.0 22:52:23 INFO - PROCESS | 12236 | 22:52:23 INFO - PROCESS | 12236 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:70.00 stddev:6.39 (9.1%) stddev-sans-first:6.77 22:52:23 INFO - PROCESS | 12236 | Values: 71.0 72.0 70.0 70.0 69.0 69.0 70.0 90.0 69.0 70.0 22:52:23 INFO - PROCESS | 12236 | -------- Summary: end -------- 22:52:23 INFO - PROCESS | 12236 | 22:52:24 INFO - TEST-INFO | 12236: exit 0 22:52:24 INFO - TEST-OK | kraken | took 64713ms 22:52:24 INFO - SUITE-END | took 1186s 22:52:25 INFO - Completed test suite (00:19:47) 22:52:25 INFO - javascript benchmark 22:52:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2578.587426011838, 2612.882420291087, 2657.8139530232893, 2658.069675613535, 2670.158899946518, 4556.293774464955, 4645.303204519324, 4723.520715969476, 4771.570558649716, 4844.467108618053, 4673.042026384592, 4674.0, 4682.204025315696, 4684.8126074957045, 4693.741844198567, 4282.78586070696, 4299.054208074219, 4305.461817272841, 4315.309550471925, 4325.437693099892, 4321.2653848845775, 4359.4768627764715, 4409.603135717784, 4433.113377324532, 4446.15523050621, 4446.733196008234, 4459.241928872099, 4460.130274596455, 4515.548445155491, 4516.051629157881, 4309.267424537836, 4401.757903315316, 4483.887902802423, 4485.484169320537, 4487.730736155841, 4224.640905523003, 4397.428334316551, 4406.757628330441, 4429.247028005247, 4446.0, 4625.190591646448, 4666.836660716858, 4693.225617773063, 4693.906121877578, 4721.362616046824, 4969.13040217964, 4970.502949705001, 4974.403071631427, 4991.800327986876, 5058.7976480940715, 5034.899302013976, 5073.441921388644, 5085.974570127163, 5087.79648814047, 5120.692758434506, 4523.140603285366, 4563.269876819693, 4677.672562920563, 4721.905561888743, 4786.0, 5154.098032844237, 5195.922061169085, 5199.142141546602, 5202.635815492955, 5254.816081437131, 4982.476839931827, 4993.90012199754, 4994.0, 4995.500449955048, 5057.115004874132, 4836.395450568679, 4905.2151655734915, 4973.975130124399, 5031.0, 5071.264666623319, 4991.326170966873, 4994.275830004629, 5018.222175562793, 5054.21659642756, 5056.721880296619, 4961.4046314441775, 4975.2288395298065, 4977.9751101244265, 4978.153713868651, 5034.0686972910125, 4156.854510092132, 4202.096549241927, 4207.158568286355, 4252.277112890816, 4253.787310634456, 3682.8710995115043, 3727.962720372816, 3733.328000959799, 3735.7571757835653, 3806.3719486284454, 4390.0, 4391.538888416734, 4401.559844015637, 4439.067795762861, 4449.866504004885, 4887.266909963534, 4958.504149585013, 5086.64393492452, 5107.387113546324, 5108.412532558729, 4288.721233119837, 4336.262835318003, 4342.609165175149, 4348.043430445297, 4406.140802543538, 4498.437695288089, 4514.7291162530355, 4517.932231016537, 4521.186186486464, 4573.771311434415, 4617.930731039104, 4728.1962066448095, 4728.361671174485, 4728.668993170445, 4780.689255198401, 4949.678270912379, 4970.701757894538, 5002.174641184164, 5024.974875125601, 5025.0, 4704.929426058543, 4709.623230141512, 4727.409073865767, 4754.23932170851, 4828.855134345975, 4994.200927851526, 5000.099982003128, 5005.774740136775, 5058.671186373022, 5058.721770302522, 5027.974860125676, 5036.445990940921, 5041.495850414929, 5045.445001049955, 5103.7448127592725, 4752.952470475251, 4816.084943860656, 4897.583705385082, 4936.58039066669, 5006.148954677787, 4914.410270767531, 4958.677685950546, 4960.826371076995, 5018.272350509083, 5028.170351891897, 4793.592544633745, 4877.3903262092235, 4893.119238537098, 4894.559489645949, 4942.1598328285, 4823.831165909317, 4877.048975449753, 5010.749462526932, 5020.723860187724, 5075.670081444694, 4809.350737650372, 4812.807487700453, 4863.878403039811, 4880.267959806058, 4933.925991110064], "value": 4634.82081942006, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.0272925110307, 570.9600327977043, 573.6758731316809, 579.0098930828286, 588.655636452675, 27401.0, 38432.80783596082, 39143.41284880729, 39231.80384098079, 43024.3546346805, 39453.8027309863, 39833.0, 39954.40068398976, 39977.80011099948, 39990.60009399905, 7557.773266801991, 7758.806029849243, 7765.650545725428, 7767.378609711238, 7776.3778897688335, 7554.50895691781, 7622.618869056525, 7634.045744281965, 7638.197989211136, 7640.5797681127515, 7665.731699390522, 7706.460547761659, 7712.1902200269005, 7714.922850771477, 7716.9614151929445, 7592.126905405894, 7600.201978792258, 7623.275788800055, 7651.349635281008, 7659.119201291867, 7599.012128423325, 7662.616869156575, 7662.65518051689, 7663.195364486704, 7665.808354791119, 36249.637503625156, 36613.0, 36618.8169059153, 36650.45024324637, 36681.0, 2958.7632989361014, 3003.429348423814, 3036.7722420818527, 3276.311974485361, 3289.5723555937575, 29088.41823163525, 29143.85428072846, 29160.416791664262, 29709.40581188364, 31024.844875775703, 3310.5034244863223, 3313.950290745641, 3480.6867381935494, 3516.613172551017, 3543.6102028776813, 239951.0, 242113.0, 243021.0, 243109.0, 243989.0, 31787.84106079501, 32300.35399292001, 32375.838120809247, 53621.46378536243, 54310.0, 33441.163970900925, 33823.0, 33843.32313353719, 33864.49203261953, 33868.1532961673, 13095.0, 13212.405441755143, 13213.73572528544, 13227.074104812764, 13228.867711322957, 10923.289986150874, 10961.56153753841, 11029.724256893642, 11034.172437067253, 11034.944825275983, 7734.57459839703, 7782.105057918298, 7793.142754297023, 7883.802904927308, 7892.9210707893335, 3069.2020074780717, 3070.585470961392, 3078.7383072439093, 3080.383923215366, 3086.182161727144, 870.5951732444444, 899.1458114790844, 900.0009988912302, 900.1898291537537, 920.3787443475627, 26474.867625661747, 28160.43679126447, 28295.29261768472, 29251.414971700447, 29823.403531929675, 737.5611511150856, 941.3645789092335, 964.0937518732369, 976.4336684722844, 979.6620166042704, 13936.790948135786, 14512.274386280644, 14632.122072675673, 14774.113553186628, 14858.479953201802, 349363.0, 352817.0, 353094.0, 353387.0, 354398.0, 49936.500634993914, 50112.24831627528, 50426.49573504218, 50494.24258636124, 50522.0, 1074.8763892152347, 1122.0798944865132, 1167.200467679642, 1175.988240117605, 1226.6136167107334, 25223.0, 29184.854075729487, 29323.0, 29456.400049757434, 29470.852645736635, 41969.79015104905, 42629.57370426256, 42728.35907461453, 42751.358729618456, 42779.57220427756, 287529.0, 290387.0, 290419.0, 290590.0, 290998.0, 24467.021319147036, 25289.747102528738, 25334.1133060342, 25374.0, 25384.365390865376, 41382.172356552095, 41896.790516048444, 42144.36783448312, 42392.36411453893, 43350.78324608357, 35148.472772908935, 35658.82170589131, 35942.8202858984, 36076.81961590175, 36345.636543634224, 35527.46708799319, 35718.28563428665, 35853.10367240736, 36039.0, 36244.09389765277, 34384.0, 34500.705408464026, 35414.468782967764, 35438.0, 35659.28681426409, 30210.69789302167, 33143.0, 33163.83418082894, 33298.0, 33308.833455833534, 24434.389140271636, 25008.249752507454, 25185.49629007446, 25196.75596264234, 25380.492390152463], "value": 16127.065293903112, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.9437333014316, 357.40135273417036, 366.61505419309725, 374.4551677309514, 379.2282704695944, 12205.694857628563, 12923.483060677574, 13545.796813047813, 16400.75398869018, 16402.83597164028, 15810.209489525536, 16070.59823504413, 16438.67122657546, 16555.91722041391, 16560.420385286518, 4931.038447502739, 5151.562117220041, 5157.252198431225, 5157.30376399185, 5158.742062896859, 3652.141746689526, 3791.9810400948095, 5655.8586035349035, 5898.321693005317, 5957.434043765836, 5673.602847800656, 5987.22166118404, 6007.8197654070445, 6018.037114061751, 6024.0, 5842.386549412315, 5872.882542349129, 5989.940100598982, 6042.818715438544, 6053.636781793107, 4656.883577910546, 4958.181899986498, 5303.4696530346655, 5303.867403314909, 5304.708241046741, 11912.927836494757, 12038.69903252417, 19201.80798192014, 19226.423207303662, 19693.704594431096, 1784.304121392645, 1939.6314700207056, 2187.0704950396016, 2302.976970230293, 2375.714914210306, 8380.916190838074, 8538.44500107491, 8586.656533738644, 8861.335399844973, 9221.400608960463, 1625.9512614363787, 1700.2263969893668, 1727.4385824607052, 1734.1156010434643, 1749.527627540557, 62763.686181569254, 67753.3224667752, 67870.66064669644, 68889.65555172192, 68984.0, 9518.428894266228, 9528.523573821281, 9544.713658590254, 9786.902130978599, 9799.314048016571, 13592.592222233348, 13612.86387136116, 13618.659533511742, 13631.522896698569, 13642.863571364358, 6958.547694399847, 7191.64041797908, 7267.200607933123, 7350.889736653954, 7392.741254056083, 6741.662916854138, 6745.3591908768585, 6845.14435695538, 6925.930740692629, 7005.754798582026, 4108.67130629549, 4140.399642051946, 4149.543550209474, 4197.118605092965, 4215.220184265921, 1661.127907848365, 1743.8256174382461, 1774.3346245158066, 1775.7869055713138, 1782.393986044751, 650.7722297195944, 749.8987636669088, 783.4280974888363, 786.1470304719329, 792.4888446951684, 15641.60895977587, 15886.52340429789, 16276.186190690654, 16314.102724350274, 16784.832151678573, 769.9345555627834, 785.7917651822272, 795.6181033104142, 819.2836008562053, 844.5523872347543, 8756.124387561193, 8947.821043579092, 9205.723828285161, 9279.582418791171, 9396.71809845692, 158697.0, 161703.0, 349981.0, 352058.0, 352394.0, 71138.28861711317, 72305.0, 80735.19264807395, 81828.95427614238, 81872.0, 887.9422837515541, 895.8566629339274, 930.1024511346583, 931.8602209668468, 932.2029664636638, 15148.469803556822, 15259.694806104038, 15934.0, 15992.520224393287, 16258.268377922785, 26687.866560667073, 36746.0, 37137.442938356486, 37578.812105939294, 37780.43329350117, 50983.49016509787, 51924.0, 52018.73990630022, 52787.472125278255, 54908.17637735517, 7332.890006649798, 7467.215942325977, 7500.699972001059, 7602.0, 7686.3850891927395, 9775.266854986046, 11334.0, 11589.710257243636, 11814.409279535817, 11895.583654572049, 9290.442573445614, 9527.475988820404, 9815.803683926424, 10061.245406594388, 10106.696799096038, 9697.9030209697, 9715.125638692552, 9727.270454716067, 9836.950815245878, 9985.350952188084, 9614.95192524033, 9640.0, 9992.700218993441, 10282.0, 10552.525136368728, 7293.088363954505, 7557.395408367427, 7596.392288617008, 7647.923520764721, 7945.8410831781885, 9382.48396338208, 9445.52772361393, 9517.669460395642, 9894.653687120915, 9922.503874806374], "value": 7887.672337147992, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1336.0313772514926, 1371.3623165228166, 1411.442480220313, 1601.4394961763392, 1634.8528632423072, 6634.237062737787, 6870.587764734107, 7075.46933979951, 7685.846283074342, 7701.92298077019, 7404.4816862819625, 7722.382209423246, 7722.536647801136, 7741.49680270782, 7751.844963100734, 2122.8089471947524, 2141.100737690166, 2155.4719093822036, 2159.5788821179876, 2162.156758864044, 1793.9641207175914, 1846.1876774219368, 2022.0294258755805, 2084.3017589107667, 2109.789021097886, 2074.647309957311, 2099.4436474334316, 2101.338078505266, 2116.7036614873855, 2120.204923153817, 2036.3483685220735, 2041.3263623004373, 2042.2443695832562, 2050.507878109258, 2077.4598604362973, 2002.5294055896852, 2004.0681083296338, 2007.2673474181966, 2008.0863207240816, 2011.3965810256864, 7545.660445279976, 7547.811304717371, 7582.772516824449, 7605.201453847321, 7654.808629784245, 4268.445102136702, 4377.23398405281, 4381.38660587518, 4401.933970990406, 4405.889852753675, 2650.2314328844614, 2656.375751698349, 2757.3382388226883, 2772.279207406069, 2777.402858385457, 896.0546623312403, 901.6708901250996, 907.7594437474074, 1703.8296170382987, 1778.2797966823457, 10256.538455769509, 10283.560301557787, 10345.431001294926, 10380.688579342708, 10393.376397416103, 3758.699304055669, 3759.586445490994, 3902.512185976753, 3906.628870257378, 3913.5108111486065, 7986.7603971880935, 7991.800204994805, 7998.680052797939, 8003.4797738146835, 8007.559584222807, 4322.805473753689, 4323.870283891489, 4327.6105150536605, 4327.675424343124, 4330.480342358937, 4005.819738111792, 4018.3972404139613, 4027.859024934113, 4028.456158418576, 4030.6976976726864, 3313.0, 3406.5741782277214, 3411.914702132417, 3425.3663072331697, 3495.213576945167, 975.687779910436, 980.9362391444533, 1025.661531694539, 1045.3675526306627, 1052.2055847834836, 664.3389827122045, 759.9924000760033, 808.8058865872266, 811.5090370325986, 856.6230858422274, 5004.424491183488, 5134.743262836918, 5157.690538567698, 5324.547413469821, 5416.458354164631, 849.2017503546647, 885.6634478897978, 891.7012800711834, 897.156672727647, 900.4732231644562, 3570.589382221078, 3655.0314166745834, 3659.323025240339, 3673.1184515716036, 3920.17676287977, 8964.506952117566, 9482.051794820463, 9524.952375238217, 9555.952220238854, 9558.808823823485, 9388.95305523468, 9421.199198068241, 9426.434413935185, 9426.95286523563, 9438.764030899283, 6794.932050679528, 6976.651167441608, 7017.193022802443, 7210.1708303545765, 7213.170485394142, 5254.6847189168775, 5383.973080134731, 5460.808871689472, 5493.7802487900035, 5754.0, 8133.918660813553, 8238.0, 8612.526311052701, 8654.740357789276, 8664.0, 8195.46729462583, 8635.481871087755, 8845.601947912488, 8927.062658420773, 8936.821263574562, 7183.497155199295, 7424.591647459441, 7425.8143546411775, 7428.814279643052, 7430.7027718892805, 7363.705451781869, 7417.369523590555, 7429.777106686808, 7436.405087593088, 7445.032145821226, 6413.038044293206, 6599.274079851309, 6671.5997040177745, 6688.230853451915, 6783.287754785873, 6548.639824809681, 6559.0, 6562.146920900253, 6633.6019838809825, 6730.764423245163, 6041.456268935817, 6162.0, 6190.938090619036, 6223.782167624111, 6232.75068997235, 4489.573490518395, 4551.203539380529, 4650.651201159859, 4660.184467718203, 4830.661853670209, 4429.357743127293, 4598.655100867381, 4600.42494688164, 4602.493725690105, 4650.4186976627925], "value": 4039.060827601583, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [266.3434633628106, 283.63552834607526, 286.3357011732781, 287.7395956659224, 292.2299740184613, 4569.908601827961, 4826.638002149835, 4828.275758636207, 4863.294822250771, 4869.902601947959, 4577.725336479805, 4741.90516189676, 4786.521347865212, 4806.567408933195, 4894.119058569456, 3563.4476656118213, 3675.191457879262, 3770.2836461072307, 3772.886813395589, 3787.4508196311517, 3640.3447379471686, 3743.582572564373, 3764.6047165047685, 3770.396736522157, 3787.541796408389, 3727.3104475671953, 3744.2511497700434, 3744.681702055315, 3746.4567637692517, 3768.8492460301554, 3749.8312575934146, 3757.2485502899394, 3763.9435408468894, 3779.6787273081545, 3780.489633899416, 3251.577294951665, 3305.074579117851, 3330.5004249362546, 3337.1156643489494, 3352.379809735207, 4645.256758918556, 4658.161530924433, 4658.86023419298, 4669.486356500782, 4685.4377474702915, 4238.809253583596, 4266.488021437447, 4270.416398079148, 4276.3799249109015, 4278.994436307466, 4825.565699087064, 5005.34930459038, 5031.949680503221, 5032.748362581893, 5039.974800126012, 3531.1525233943667, 3536.3634545781747, 3537.823108844573, 3543.6102028776813, 3553.5380400547765, 5262.05283049051, 5279.340082489689, 5309.469053094698, 5314.7608357624, 5323.85892323531, 3475.461303497962, 3541.4974342717665, 3597.546355498698, 3637.1452708613456, 3666.7249956253386, 3676.371394452979, 3676.5036720042986, 3679.1721862580707, 3680.8773324136396, 3690.4833323334756, 4217.978910105491, 4253.298205796009, 4261.87214383569, 4283.507396649363, 4285.142971405731, 4805.183118869801, 4880.6095512358925, 4948.183549714328, 5015.749212539431, 5077.466865979093, 1248.5329737558332, 1261.2180448122224, 1263.879931406515, 1270.39021269791, 1272.9498164014724, 772.3820943245381, 787.8463699578642, 802.3340627279345, 803.1648281566081, 820.335528222142, 4041.191761647682, 4041.2927737645796, 4068.7965601719798, 4079.5925405734974, 4086.693497987603, 4512.3908272382805, 4579.793909274091, 4601.930971035437, 4614.031053478807, 4644.698094623838, 3995.3430968406265, 4023.91952160961, 4040.9797951010055, 4048.8987775305263, 4059.573744756817, 2268.8298377621745, 2416.5046165536023, 2430.283066495388, 2452.5217582571227, 2463.2733343663663, 4323.502797178302, 4323.654107671378, 4337.327714204241, 4373.431453910971, 4383.715058521186, 4655.348251244828, 4674.205385084544, 4719.955628619521, 4727.912580106595, 4739.620830333565, 4093.6841158661578, 4310.7929779661745, 4335.9187589957, 4336.848210312624, 4337.934930976038, 4565.429321334833, 4578.771061446981, 4585.518520555293, 4591.977040114778, 4595.632349412106, 4497.595216430537, 4509.481409637933, 4522.660800439914, 4524.054656497738, 4543.295789152687, 3992.9001774954695, 4287.935680964725, 4351.259496201418, 4354.281543545279, 4366.563343665608, 3328.450805617046, 3333.4833100869405, 3335.8332083396217, 3348.4977253412185, 3395.5076513905838, 4600.3329517219145, 4603.470600880942, 4681.976590117028, 4693.108309421199, 5008.3238762768015, 4945.604351651931, 5037.236967061499, 5068.670536415121, 5069.163588008085, 5112.335396398445, 4998.525140111684, 5013.974930125326, 5038.269450929522, 5039.521245481674, 5040.656094915882, 4811.446683631287, 4974.651774375759, 4994.625403094709, 5001.449840517467, 5041.269015992587, 5112.0, 5125.282460455614, 5126.410462796677, 5128.564072053917, 5142.51146141116, 5020.723860187724, 5021.196608542616, 5030.4718004608985, 5036.571891389273, 5054.823081192288], "value": 3639.8526949516877, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [610.9602875813073, 708.9184743754466, 717.7093277222723, 730.7223255163037, 736.5212611802327, 12687.11190216684, 13490.325483725823, 13499.460021599125, 13515.932420337896, 13525.864741352596, 11730.944215020647, 13522.797158042613, 13615.795763063563, 13672.111312764688, 13672.453101875913, 731.2650785960116, 733.7615275035608, 739.4380270994029, 739.5414842797474, 741.5143081281769, 754.3625636337287, 754.9962250188742, 755.8337165823538, 756.058706909898, 756.0813611462072, 778.5250996891891, 779.1585088104833, 779.185750890321, 779.668640827646, 779.8323360477497, 772.4554189296589, 776.0764690018859, 776.2547953964173, 776.3362325211975, 777.3276116159537, 570.1647087017498, 570.3583468597827, 570.3982298674896, 570.6547538739086, 572.1246492865922, 12107.515699372014, 12238.877611223952, 12275.570355037531, 12281.508739650404, 12283.508659653604, 11014.0, 11149.554017839358, 11231.10151187903, 11624.88375116255, 11753.0, 9428.952855235748, 9471.47906865122, 9813.754656133582, 9845.753856153582, 9914.504274786232, 3188.984055079733, 3203.8077715337154, 3269.182704323919, 3285.983570082158, 3322.7840190387546, 61483.0, 63046.684766576334, 63213.367866321205, 63533.0, 64683.67658161726, 8565.27195188416, 8777.824443511094, 8801.823963520694, 8848.292136629054, 8861.822763544822, 17306.48080557585, 17308.826911730972, 17317.134143292784, 17317.22072506715, 17337.65324693499, 6666.300038495985, 6672.199336079701, 6777.762778302736, 6954.374106330454, 7067.82330441743, 3671.706263498914, 3730.8321125548873, 3740.5511338638994, 3746.38184699527, 3760.2479504099288, 2799.202227365191, 2892.7251911068415, 2905.956410653842, 2909.418116376733, 2915.5772412999995, 486.8442098528508, 487.10372913838705, 490.36742602043677, 490.41395532339226, 494.2956287290597, 516.8681986093522, 585.745200837637, 626.139058794158, 659.8911179655303, 661.8979399300111, 7711.332170854417, 8165.387595930329, 8565.785855353666, 8667.739967800977, 8865.423747456394, 619.1548536248079, 629.8425393651587, 640.8013515810114, 642.5534253693731, 648.4909346163239, 3926.9018274542796, 4095.692823038284, 4205.74765514064, 4385.276429389115, 4407.801648925806, 73431.63284183545, 76974.615126924, 77089.614551928, 88413.55793220992, 98055.0, 76899.0, 78291.0, 78815.0, 81051.18948810437, 81483.0, 67723.0, 67830.0, 68974.0, 69382.3061769386, 70360.0, 8572.614232359434, 9104.544772761468, 9159.725208243763, 9168.908310916806, 9243.491607961358, 40799.79600101981, 41322.0, 41985.0, 42311.153776923675, 42585.78707106445, 58408.70795645995, 60500.0, 62840.371596283454, 65900.0, 66843.66578167077, 11170.832437513607, 11579.305241685526, 12103.0, 12295.815562766387, 12866.935665321613, 12889.09776315649, 13384.93307533456, 13571.728565428833, 13835.155802425843, 14347.067440616327, 12440.75118497643, 12687.81302170275, 12765.170263932814, 12765.297908614744, 13498.392572334466, 11105.333679978903, 12510.562130325396, 12813.423395947018, 12879.871201287868, 13613.727725445633, 11965.222260553037, 12108.576199832964, 12290.75418491643, 12317.384130793245, 12644.683882903, 9392.20166285846, 9395.24838012971, 9599.616015359587, 9945.602175912882, 10045.246606504688, 10862.674119776419, 10970.890291096986, 11119.0, 11156.24532162303, 11332.036776874058], "value": 6502.184870697904, "unit": "score"}], "name": "dromaeo_css", "value": 6192.055767096964, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 117.0, 115.0, 114.0, 114.0, 115.0, 117.0, 114.0, 115.0, 114.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 132.0, 127.0, 166.0, 130.0, 132.0, 127.0, 128.0, 161.0, 128.0], "value": 138.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 162.0, 162.0, 162.0, 162.0, 163.0, 161.0, 164.0, 164.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 111.0, 78.0, 77.0, 76.0, 76.0, 98.0, 76.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 112.0, 82.0, 83.0, 83.0, 117.0, 83.0, 82.0, 113.0], "value": 92.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 148.0, 147.0, 148.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 94.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 65.0, 64.0, 65.0, 68.0, 66.0, 65.0, 65.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 65.0, 66.0, 65.0, 66.0, 66.0, 66.0, 66.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 84.0, 82.0, 83.0, 83.0, 84.0, 83.0, 83.0, 82.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 140.0, 137.0, 137.0, 137.0, 142.0, 136.0, 137.0, 181.0, 139.0], "value": 142.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 177.0, 181.0, 173.0, 177.0, 183.0, 174.0, 175.0, 178.0, 186.0], "value": 178.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 70.0, 70.0, 69.0, 69.0, 70.0, 90.0, 69.0, 70.0], "value": 72.0, "unit": "score"}], "name": "kraken", "value": 1555.6999999999998, "alertThreshold": 2.0}]} 22:52:25 INFO - Return code: 0 22:52:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:52:25 INFO - # TBPL SUCCESS # 22:52:25 INFO - Running post-action listener: _resource_record_post_action 22:52:25 INFO - [mozharness: 2016-10-08 05:52:25.416401Z] Finished run-tests step (success) 22:52:25 INFO - Running post-run listener: _resource_record_post_run 22:52:25 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 0; Write bytes: 402583552; Read time: 0; Write time: 257020 22:52:25 INFO - TinderboxPrint: CPU usage
13.1% 22:52:25 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 22:52:25 INFO - TinderboxPrint: I/O write bytes / time
402,583,552 / 257,020 22:52:25 INFO - TinderboxPrint: CPU idle
8,346.2 (86.9%) 22:52:25 INFO - TinderboxPrint: CPU user
1,211.4 (12.6%) 22:52:25 INFO - TinderboxPrint: Swap in / out
0 / 0 22:52:25 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110694400; Read time: 0; Write time: 67540 22:52:25 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 291889152; Read time: 0; Write time: 189480 22:52:26 INFO - Running post-run listener: _upload_blobber_files 22:52:26 INFO - Blob upload gear active. 22:52:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:52:26 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 22:52:26 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'] 22:52:26 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 22:52:26 INFO - (blobuploader) - INFO - Open directory for files ... 22:52:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:52:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:52:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:52:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:52:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:52:30 INFO - (blobuploader) - INFO - Done attempting. 22:52:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:52:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:52:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:52:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:52:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:52:31 INFO - (blobuploader) - INFO - Done attempting. 22:52:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:52:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:52:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:52:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:52:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:52:31 INFO - (blobuploader) - INFO - Done attempting. 22:52:31 INFO - (blobuploader) - INFO - Iteration through files over. 22:52:31 INFO - Return code: 0 22:52:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:52:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:52:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/55e1265a42321ae07af066ad79e271000e7a76d64c3908a302afd62a62d8ca50a4429408d3989e3a63dea86ee1e75114ad820f9dcee1ec3e154d0fdb2a5d20c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/52ef4cc84d332e7f0b81ca2f739a121dec84d6c3a63ba588881d9c3a07ee4871b4bb862cf5204a0700b80870c80f3a047f6ad53355eda9af71df4a272deaa92a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d7d729ae1bbb1a05cab9799918389bbd3dc849772ca38b8b2751ca33845a07a0d2089ce735c74f358f6ca9e7f8a909a6fd2d8d07fb578d91ce7a8d57cde8624f"} 22:52:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:52:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:52:31 INFO - Contents: 22:52:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/55e1265a42321ae07af066ad79e271000e7a76d64c3908a302afd62a62d8ca50a4429408d3989e3a63dea86ee1e75114ad820f9dcee1ec3e154d0fdb2a5d20c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/52ef4cc84d332e7f0b81ca2f739a121dec84d6c3a63ba588881d9c3a07ee4871b4bb862cf5204a0700b80870c80f3a047f6ad53355eda9af71df4a272deaa92a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d7d729ae1bbb1a05cab9799918389bbd3dc849772ca38b8b2751ca33845a07a0d2089ce735c74f358f6ca9e7f8a909a6fd2d8d07fb578d91ce7a8d57cde8624f"} 22:52:31 INFO - Running post-run listener: copy_logs_to_upload_dir 22:52:31 INFO - Copying logs to upload dir... 22:52:31 INFO - mkdir: /builds/slave/test/build/upload/logs 22:52:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.957980 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-07 22:52:31.616346) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 22:52:31.620237) ========= 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=db0483c52d987ecb441a263b000001ad-1475904651.670711-254927590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/55e1265a42321ae07af066ad79e271000e7a76d64c3908a302afd62a62d8ca50a4429408d3989e3a63dea86ee1e75114ad820f9dcee1ec3e154d0fdb2a5d20c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/52ef4cc84d332e7f0b81ca2f739a121dec84d6c3a63ba588881d9c3a07ee4871b4bb862cf5204a0700b80870c80f3a047f6ad53355eda9af71df4a272deaa92a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d7d729ae1bbb1a05cab9799918389bbd3dc849772ca38b8b2751ca33845a07a0d2089ce735c74f358f6ca9e7f8a909a6fd2d8d07fb578d91ce7a8d57cde8624f"} build_url:https://queue.taskcluster.net/v1/task/YyYrXhKeS9GaXi3fepA18A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011492 build_url: 'https://queue.taskcluster.net/v1/task/YyYrXhKeS9GaXi3fepA18A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/55e1265a42321ae07af066ad79e271000e7a76d64c3908a302afd62a62d8ca50a4429408d3989e3a63dea86ee1e75114ad820f9dcee1ec3e154d0fdb2a5d20c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/52ef4cc84d332e7f0b81ca2f739a121dec84d6c3a63ba588881d9c3a07ee4871b4bb862cf5204a0700b80870c80f3a047f6ad53355eda9af71df4a272deaa92a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d7d729ae1bbb1a05cab9799918389bbd3dc849772ca38b8b2751ca33845a07a0d2089ce735c74f358f6ca9e7f8a909a6fd2d8d07fb578d91ce7a8d57cde8624f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 22:52:31.647292) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 22:52:31.647684) ========= 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=db0483c52d987ecb441a263b000001ad-1475904651.670711-254927590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004513 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 22:52:31.731233) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 22:52:31.731613) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 22:52:31.731988) ========= ========= Total master_lag: 0.18 =========