builder: autoland_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-054 starttime: 1475587397.93 results: success (0) buildid: 20161004033013 builduid: 2fa6661840214bae825e97b2350492de revision: 1a5030f96cdb8ac74e44d8ba776633354d1fa428 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 06:23:17.930243) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 06:23:17.930857) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 06:23:17.931291) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 06:23:17.946985) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 06:23:17.947285) ========= 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=cbe409c6de289db6ac707de3000001d4-1475583495.835933-1480351109 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-04 06:23:18-- 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% 16.2M=0.001s 2016-10-04 06:23:18 (16.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115675 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 06:23:18.076969) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 06:23:18.077317) ========= 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=cbe409c6de289db6ac707de3000001d4-1475583495.835933-1480351109 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017440 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 06:23:18.130699) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-04 06:23:18.131425) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 1a5030f96cdb8ac74e44d8ba776633354d1fa428 --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 1a5030f96cdb8ac74e44d8ba776633354d1fa428 --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=cbe409c6de289db6ac707de3000001d4-1475583495.835933-1480351109 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-04 06:23:18,669 truncating revision to first 12 chars 2016-10-04 06:23:18,670 Setting DEBUG logging. 2016-10-04 06:23:18,670 attempt 1/10 2016-10-04 06:23:18,670 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/1a5030f96cdb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-04 06:23:19,554 unpacking tar archive at: autoland-1a5030f96cdb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.220462 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-04 06:23:19.368436) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 06:23:19.369340) ========= script_repo_revision: 1a5030f96cdb8ac74e44d8ba776633354d1fa428 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 06:23:19.370862) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 06:23:19.371437) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 06:23:19.382624) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-10-04 06:23:19.383250) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=cbe409c6de289db6ac707de3000001d4-1475583495.835933-1480351109 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:23:20 INFO - MultiFileLogger online at 20161004 06:23:20 in /builds/slave/test 06:23:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 06:23:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:23:20 INFO - {'append_to_log': False, 06:23:20 INFO - 'base_work_dir': '/builds/slave/test', 06:23:20 INFO - 'blob_upload_branch': 'Autoland', 06:23:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:23:20 INFO - 'branch': 'Autoland', 06:23:20 INFO - 'buildbot_json_path': 'buildprops.json', 06:23:20 INFO - 'config_files': ('talos/linux_config.py',), 06:23:20 INFO - 'default_actions': ('clobber', 06:23:20 INFO - 'read-buildbot-config', 06:23:20 INFO - 'download-and-extract', 06:23:20 INFO - 'populate-webroot', 06:23:20 INFO - 'create-virtualenv', 06:23:20 INFO - 'install', 06:23:20 INFO - 'run-tests'), 06:23:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:23:20 INFO - 'download_minidump_stackwalk': True, 06:23:20 INFO - 'download_symbols': 'ondemand', 06:23:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:23:20 INFO - 'tooltool.py': '/tools/tooltool.py', 06:23:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:23:20 INFO - '/tools/misc-python/virtualenv.py')}, 06:23:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:23:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:23:20 INFO - 'installer_path': 'installer.exe', 06:23:20 INFO - 'log_level': 'info', 06:23:20 INFO - 'log_name': 'talos', 06:23:20 INFO - 'log_to_console': True, 06:23:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:23:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:23:20 INFO - 'opt_config_files': (), 06:23:20 INFO - 'pip_index': False, 06:23:20 INFO - 'sps_profile': False, 06:23:20 INFO - 'sps_profile_interval': 0, 06:23:20 INFO - 'suite': 'dromaeojs', 06:23:20 INFO - 'system_bits': '32', 06:23:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:23:20 INFO - 'title': 'talos-linux64-ix-054', 06:23:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:23:20 INFO - 'use_talos_json': True, 06:23:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:23:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:23:20 INFO - 'work_dir': 'build'} 06:23:20 INFO - [mozharness: 2016-10-04 13:23:20.014594Z] Running clobber step. 06:23:20 INFO - Running pre-action listener: _resource_record_pre_action 06:23:20 INFO - Running main action method: clobber 06:23:20 INFO - rmtree: /builds/slave/test/build 06:23:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:23:20 INFO - Running post-action listener: _resource_record_post_action 06:23:20 INFO - [mozharness: 2016-10-04 13:23:20.471901Z] Finished clobber step (success) 06:23:20 INFO - [mozharness: 2016-10-04 13:23:20.472003Z] Running read-buildbot-config step. 06:23:20 INFO - Running pre-action listener: _resource_record_pre_action 06:23:20 INFO - Running main action method: read_buildbot_config 06:23:20 INFO - Using buildbot properties: 06:23:20 INFO - { 06:23:20 INFO - "project": "", 06:23:20 INFO - "product": "firefox", 06:23:20 INFO - "script_repo_revision": "production", 06:23:20 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 06:23:20 INFO - "repository": "", 06:23:20 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs", 06:23:20 INFO - "buildid": "20161004033013", 06:23:20 INFO - "pgo_build": "True", 06:23:20 INFO - "basedir": "/builds/slave/test", 06:23:20 INFO - "buildnumber": 288, 06:23:20 INFO - "slavename": "talos-linux64-ix-054", 06:23:20 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:23:20 INFO - "platform": "ubuntu64_hw", 06:23:20 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 06:23:20 INFO - "branch": "autoland", 06:23:20 INFO - "repo_path": "integration/autoland", 06:23:20 INFO - "revision": "1a5030f96cdb8ac74e44d8ba776633354d1fa428", 06:23:20 INFO - "stage_platform": "linux64-pgo", 06:23:20 INFO - "builduid": "2fa6661840214bae825e97b2350492de", 06:23:20 INFO - "slavebuilddir": "test" 06:23:20 INFO - } 06:23:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/bMH63fvVSq2JtoPw78lB2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 06:23:20 INFO - Running post-action listener: _resource_record_post_action 06:23:20 INFO - [mozharness: 2016-10-04 13:23:20.474454Z] Finished read-buildbot-config step (success) 06:23:20 INFO - [mozharness: 2016-10-04 13:23:20.474543Z] Running download-and-extract step. 06:23:20 INFO - Running pre-action listener: _resource_record_pre_action 06:23:20 INFO - Running main action method: download_and_extract 06:23:20 INFO - mkdir: /builds/slave/test/build/tests 06:23: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')]} 06:23:20 INFO - trying https://queue.taskcluster.net/v1/task/bMH63fvVSq2JtoPw78lB2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:23:20 INFO - Downloading https://queue.taskcluster.net/v1/task/bMH63fvVSq2JtoPw78lB2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:23:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bMH63fvVSq2JtoPw78lB2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:23:24 INFO - Downloaded 1361 bytes. 06:23:24 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:23:24 INFO - Using the following test package requirements: 06:23:24 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:23:24 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:23:24 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:23:24 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:23:24 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:23:24 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:23:24 INFO - u'jsshell-linux-x86_64.zip'], 06:23:24 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:23:24 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:23:24 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:23:24 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:23:24 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:23:24 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:23:24 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:23:24 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:23:24 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:23:24 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:23:24 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:23:24 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:23:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bMH63fvVSq2JtoPw78lB2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:23:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bMH63fvVSq2JtoPw78lB2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:23:24 INFO - Fetch https://queue.taskcluster.net/v1/task/bMH63fvVSq2JtoPw78lB2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:23:24 INFO - Http code: 200 06:23:24 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 06:23:24 INFO - x-amz-cf-id: YgTpKCkTKaDNZdkNeJSvoygoK5BPt983N71Dg5V72WvkG6HfE32OlQ== 06:23:24 INFO - x-amz-version-id: uJShtY2jf5G7jExDGR8EMdf0BqQ.tCRQ 06:23:24 INFO - Expected file size: 21992616 06:23:24 INFO - Obtained file size: 21992616 06:23:28 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:23:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bMH63fvVSq2JtoPw78lB2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:23:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bMH63fvVSq2JtoPw78lB2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:23:28 INFO - Fetch https://queue.taskcluster.net/v1/task/bMH63fvVSq2JtoPw78lB2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:23:29 INFO - Http code: 200 06:23:29 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 06:23:29 INFO - x-amz-cf-id: 1w7G7zC5-Biq3lN1Rn5zvGvinqf3s4n5611CPMA8Gf7_XlJLQXzHiQ== 06:23:29 INFO - x-amz-version-id: uJShtY2jf5G7jExDGR8EMdf0BqQ.tCRQ 06:23:29 INFO - Expected file size: 21992616 06:23:29 INFO - Obtained file size: 21992616 06:23:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bMH63fvVSq2JtoPw78lB2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 06:23:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bMH63fvVSq2JtoPw78lB2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:23:34 INFO - Fetch https://queue.taskcluster.net/v1/task/bMH63fvVSq2JtoPw78lB2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 06:23:34 INFO - Http code: 200 06:23:34 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 06:23:34 INFO - x-amz-cf-id: 7OhvCdDYZM7ki_AHyp4LXMWc03CyLMrpP-ViR8VxdKaJjFhDBlR3bA== 06:23:34 INFO - x-amz-version-id: TL7NRN1qwJ1J93diXlf5nkFPNOsE6C2U 06:23:34 INFO - Expected file size: 14409006 06:23:34 INFO - Obtained file size: 14409006 06:23:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:35 INFO - trying https://queue.taskcluster.net/v1/task/bMH63fvVSq2JtoPw78lB2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:23:35 INFO - Downloading https://queue.taskcluster.net/v1/task/bMH63fvVSq2JtoPw78lB2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:23:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bMH63fvVSq2JtoPw78lB2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:23:36 INFO - Downloaded 59704431 bytes. 06:23:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bMH63fvVSq2JtoPw78lB2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:23:36 INFO - mkdir: /builds/slave/test/properties 06:23:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:23:36 INFO - Writing to file /builds/slave/test/properties/build_url 06:23:36 INFO - Contents: 06:23:36 INFO - build_url:https://queue.taskcluster.net/v1/task/bMH63fvVSq2JtoPw78lB2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:23:36 INFO - Running post-action listener: _resource_record_post_action 06:23:36 INFO - Running post-action listener: set_extra_try_arguments 06:23:36 INFO - [mozharness: 2016-10-04 13:23:36.972534Z] Finished download-and-extract step (success) 06:23:36 INFO - [mozharness: 2016-10-04 13:23:36.972761Z] Running populate-webroot step. 06:23:36 INFO - Running pre-action listener: _resource_record_pre_action 06:23:36 INFO - Running main action method: populate_webroot 06:23:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:23:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:23:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:23:36 INFO - '--tppagecycles', 06:23:36 INFO - '7'], 06:23:36 INFO - 'tests': ['tsvgm']}}, 06:23:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:23:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:23:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:23:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:23:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:23:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:23:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:36 INFO - 'talos_options': ['--disable-e10s'], 06:23:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:23:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:23:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:36 INFO - 'talos_options': ['--disable-e10s'], 06:23:36 INFO - 'tests': ['damp', 'tps']}, 06:23:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:36 INFO - 'tests': ['damp', 'tps']}, 06:23:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:23:36 INFO - 'tests': ['dromaeo_dom']}, 06:23:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:23:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:23:36 INFO - 'tests': ['basic_compositor_video']}, 06:23:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:23:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:23:36 INFO - 'tests': ['a11yr', 06:23:36 INFO - 'ts_paint', 06:23:36 INFO - 'tpaint', 06:23:36 INFO - 'sessionrestore', 06:23:36 INFO - 'sessionrestore_no_auto_restore', 06:23:36 INFO - 'tabpaint']}, 06:23:36 INFO - 'other-e10s': {'tests': ['a11yr', 06:23:36 INFO - 'ts_paint', 06:23:36 INFO - 'tpaint', 06:23:36 INFO - 'sessionrestore', 06:23:36 INFO - 'sessionrestore_no_auto_restore', 06:23:36 INFO - 'tabpaint']}, 06:23:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:23:36 INFO - 'ts_paint', 06:23:36 INFO - 'tpaint', 06:23:36 INFO - 'sessionrestore', 06:23:36 INFO - 'sessionrestore_no_auto_restore', 06:23:36 INFO - 'tabpaint']}, 06:23:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:23:36 INFO - 'ts_paint', 06:23:36 INFO - 'tpaint', 06:23:36 INFO - 'sessionrestore', 06:23:36 INFO - 'sessionrestore_no_auto_restore', 06:23:36 INFO - 'tabpaint']}, 06:23:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:23:36 INFO - 'tests': ['a11yr', 06:23:36 INFO - 'ts_paint', 06:23:36 INFO - 'tpaint', 06:23:36 INFO - 'sessionrestore', 06:23:36 INFO - 'sessionrestore_no_auto_restore', 06:23:36 INFO - 'tabpaint']}, 06:23:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:23:36 INFO - 'tests': ['a11yr', 06:23:36 INFO - 'ts_paint', 06:23:36 INFO - 'tpaint', 06:23:36 INFO - 'sessionrestore', 06:23:36 INFO - 'sessionrestore_no_auto_restore', 06:23:36 INFO - 'tabpaint']}, 06:23:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:23:36 INFO - 'tests': ['tsvgx', 06:23:36 INFO - 'tsvgr_opacity', 06:23:36 INFO - 'tart', 06:23:36 INFO - 'tscrollx', 06:23:36 INFO - 'cart']}, 06:23:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:23:36 INFO - 'tsvgr_opacity', 06:23:36 INFO - 'tart', 06:23:36 INFO - 'tscrollx', 06:23:36 INFO - 'cart']}, 06:23:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:36 INFO - 'talos_options': ['--disable-e10s'], 06:23:36 INFO - 'tests': ['tp5o']}, 06:23:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:36 INFO - 'tests': ['tp5o']}, 06:23:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:36 INFO - 'talos_options': ['--disable-e10s', 06:23:36 INFO - '--xperf_path', 06:23:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:23:36 INFO - 'tests': ['tp5n']}, 06:23:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:36 INFO - 'talos_options': ['--xperf_path', 06:23:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:23:36 INFO - 'tests': ['tp5n']}}, 06:23:36 INFO - 'talos.zip': {'path': '', 06:23:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:23:36 INFO - Running post-action listener: _resource_record_post_action 06:23:36 INFO - [mozharness: 2016-10-04 13:23:36.990088Z] Finished populate-webroot step (success) 06:23:36 INFO - [mozharness: 2016-10-04 13:23:36.990177Z] Running create-virtualenv step. 06:23:36 INFO - Running pre-action listener: _resource_record_pre_action 06:23:36 INFO - Running main action method: create_virtualenv 06:23:36 INFO - Creating virtualenv /builds/slave/test/build/venv 06:23:36 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:23:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:23:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:23:37 INFO - Using real prefix '/usr' 06:23:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:23:37 INFO - Installing distribute.............................................................................................................................................................................................done. 06:23:39 INFO - Installing pip.................done. 06:23:39 INFO - Return code: 0 06:23:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:23:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:23:39 INFO - Reading from file tmpfile_stdout 06:23:39 INFO - Output received: 06:23:39 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 06:23:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:23:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:39 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 0x7fb29adecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1477790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1474930>, '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 0x1475830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1475cc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1475583495.835933-1480351109', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:23:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:23:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:23:39 INFO - Using env: {'DISPLAY': ':0', 06:23:39 INFO - 'HOME': '/home/cltbld', 06:23:39 INFO - 'LANG': 'en_US.UTF-8', 06:23:39 INFO - 'LANGUAGE': 'en_US:en', 06:23:39 INFO - 'LOGNAME': 'cltbld', 06:23:39 INFO - 'MAIL': '/var/mail/cltbld', 06:23:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:39 INFO - 'MOZ_NO_REMOTE': '1', 06:23:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:39 INFO - 'NO_EM_RESTART': '1', 06:23:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:39 INFO - 'PWD': '/builds/slave/test', 06:23:39 INFO - 'SHELL': '/bin/bash', 06:23:39 INFO - 'SHLVL': '1', 06:23:39 INFO - 'TERM': 'linux', 06:23:39 INFO - 'TMOUT': '86400', 06:23:39 INFO - 'USER': 'cltbld', 06:23:39 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1475583495.835933-1480351109', 06:23:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:39 INFO - '_': '/tools/buildbot/bin/python'} 06:23:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:39 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:23:39 INFO - Cleaning up... 06:23:40 INFO - Return code: 0 06:23:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:40 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 0x7fb29adecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1477790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1474930>, '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 0x1475830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1475cc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1475583495.835933-1480351109', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:23:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:23:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:23:40 INFO - Using env: {'DISPLAY': ':0', 06:23:40 INFO - 'HOME': '/home/cltbld', 06:23:40 INFO - 'LANG': 'en_US.UTF-8', 06:23:40 INFO - 'LANGUAGE': 'en_US:en', 06:23:40 INFO - 'LOGNAME': 'cltbld', 06:23:40 INFO - 'MAIL': '/var/mail/cltbld', 06:23:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:40 INFO - 'MOZ_NO_REMOTE': '1', 06:23:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:40 INFO - 'NO_EM_RESTART': '1', 06:23:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:40 INFO - 'PWD': '/builds/slave/test', 06:23:40 INFO - 'SHELL': '/bin/bash', 06:23:40 INFO - 'SHLVL': '1', 06:23:40 INFO - 'TERM': 'linux', 06:23:40 INFO - 'TMOUT': '86400', 06:23:40 INFO - 'USER': 'cltbld', 06:23:40 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1475583495.835933-1480351109', 06:23:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:40 INFO - '_': '/tools/buildbot/bin/python'} 06:23:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:40 INFO - Downloading/unpacking psutil>=3.1.1 06:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:23:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:23:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:23:42 INFO - Installing collected packages: psutil 06:23:42 INFO - Running setup.py install for psutil 06:23:42 INFO - building 'psutil._psutil_linux' extension 06:23:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:23:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:23:42 INFO - building 'psutil._psutil_posix' extension 06:23:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:23:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:23:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:23:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:23:42 INFO - Successfully installed psutil 06:23:42 INFO - Cleaning up... 06:23:42 INFO - Return code: 0 06:23:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:23:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:42 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 0x7fb29adecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1477790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1474930>, '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 0x1475830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1475cc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1475583495.835933-1480351109', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:23:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:23:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:23:42 INFO - Using env: {'DISPLAY': ':0', 06:23:42 INFO - 'HOME': '/home/cltbld', 06:23:42 INFO - 'LANG': 'en_US.UTF-8', 06:23:42 INFO - 'LANGUAGE': 'en_US:en', 06:23:42 INFO - 'LOGNAME': 'cltbld', 06:23:42 INFO - 'MAIL': '/var/mail/cltbld', 06:23:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:42 INFO - 'MOZ_NO_REMOTE': '1', 06:23:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:42 INFO - 'NO_EM_RESTART': '1', 06:23:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:42 INFO - 'PWD': '/builds/slave/test', 06:23:42 INFO - 'SHELL': '/bin/bash', 06:23:42 INFO - 'SHLVL': '1', 06:23:42 INFO - 'TERM': 'linux', 06:23:42 INFO - 'TMOUT': '86400', 06:23:42 INFO - 'USER': 'cltbld', 06:23:42 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1475583495.835933-1480351109', 06:23:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:42 INFO - '_': '/tools/buildbot/bin/python'} 06:23:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:23:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:23:44 INFO - Installing collected packages: mozsystemmonitor 06:23:44 INFO - Running setup.py install for mozsystemmonitor 06:23:45 INFO - Successfully installed mozsystemmonitor 06:23:45 INFO - Cleaning up... 06:23:45 INFO - Return code: 0 06:23:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:23: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')]} 06:23:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23: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')]} 06:23:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:45 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 0x7fb29adecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1477790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1474930>, '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 0x1475830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1475cc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1475583495.835933-1480351109', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:23:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:23:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:23:45 INFO - Using env: {'DISPLAY': ':0', 06:23:45 INFO - 'HOME': '/home/cltbld', 06:23:45 INFO - 'LANG': 'en_US.UTF-8', 06:23:45 INFO - 'LANGUAGE': 'en_US:en', 06:23:45 INFO - 'LOGNAME': 'cltbld', 06:23:45 INFO - 'MAIL': '/var/mail/cltbld', 06:23:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:45 INFO - 'MOZ_NO_REMOTE': '1', 06:23:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:45 INFO - 'NO_EM_RESTART': '1', 06:23:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:45 INFO - 'PWD': '/builds/slave/test', 06:23:45 INFO - 'SHELL': '/bin/bash', 06:23:45 INFO - 'SHLVL': '1', 06:23:45 INFO - 'TERM': 'linux', 06:23:45 INFO - 'TMOUT': '86400', 06:23:45 INFO - 'USER': 'cltbld', 06:23:45 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1475583495.835933-1480351109', 06:23:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:45 INFO - '_': '/tools/buildbot/bin/python'} 06:23:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:45 INFO - Downloading/unpacking jsonschema==2.5.1 06:23:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:23:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:47 INFO - Downloading functools32-3.2.3-2.tar.gz 06:23:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:23:47 INFO - warning: no files found matching '*.txt' 06:23:47 INFO - no previously-included directories found matching 'build' 06:23:47 INFO - no previously-included directories found matching 'dist' 06:23:47 INFO - no previously-included directories found matching '.git*' 06:23:47 INFO - Installing collected packages: jsonschema, functools32 06:23:47 INFO - Running setup.py install for functools32 06:23:47 INFO - warning: no files found matching '*.txt' 06:23:47 INFO - no previously-included directories found matching 'build' 06:23:47 INFO - no previously-included directories found matching 'dist' 06:23:47 INFO - no previously-included directories found matching '.git*' 06:23:47 INFO - Successfully installed jsonschema functools32 06:23:47 INFO - Cleaning up... 06:23:47 INFO - Return code: 0 06:23:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:47 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 0x7fb29adecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1477790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1474930>, '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 0x1475830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1475cc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1475583495.835933-1480351109', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:23:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:23:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:23:47 INFO - Using env: {'DISPLAY': ':0', 06:23:47 INFO - 'HOME': '/home/cltbld', 06:23:47 INFO - 'LANG': 'en_US.UTF-8', 06:23:47 INFO - 'LANGUAGE': 'en_US:en', 06:23:47 INFO - 'LOGNAME': 'cltbld', 06:23:47 INFO - 'MAIL': '/var/mail/cltbld', 06:23:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:47 INFO - 'MOZ_NO_REMOTE': '1', 06:23:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:47 INFO - 'NO_EM_RESTART': '1', 06:23:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:47 INFO - 'PWD': '/builds/slave/test', 06:23:47 INFO - 'SHELL': '/bin/bash', 06:23:47 INFO - 'SHLVL': '1', 06:23:47 INFO - 'TERM': 'linux', 06:23:47 INFO - 'TMOUT': '86400', 06:23:47 INFO - 'USER': 'cltbld', 06:23:47 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1475583495.835933-1480351109', 06:23:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:47 INFO - '_': '/tools/buildbot/bin/python'} 06:23:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:23:47 INFO - Cleaning up... 06:23:47 INFO - Return code: 0 06:23:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:47 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 0x7fb29adecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1477790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1474930>, '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 0x1475830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1475cc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1475583495.835933-1480351109', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:23:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:23:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:23:47 INFO - Using env: {'DISPLAY': ':0', 06:23:47 INFO - 'HOME': '/home/cltbld', 06:23:47 INFO - 'LANG': 'en_US.UTF-8', 06:23:47 INFO - 'LANGUAGE': 'en_US:en', 06:23:47 INFO - 'LOGNAME': 'cltbld', 06:23:47 INFO - 'MAIL': '/var/mail/cltbld', 06:23:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:47 INFO - 'MOZ_NO_REMOTE': '1', 06:23:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:47 INFO - 'NO_EM_RESTART': '1', 06:23:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:47 INFO - 'PWD': '/builds/slave/test', 06:23:47 INFO - 'SHELL': '/bin/bash', 06:23:47 INFO - 'SHLVL': '1', 06:23:47 INFO - 'TERM': 'linux', 06:23:47 INFO - 'TMOUT': '86400', 06:23:47 INFO - 'USER': 'cltbld', 06:23:47 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1475583495.835933-1480351109', 06:23:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:47 INFO - '_': '/tools/buildbot/bin/python'} 06:23:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:48 INFO - Downloading/unpacking blobuploader==1.2.4 06:23:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:50 INFO - Downloading blobuploader-1.2.4.tar.gz 06:23:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:23:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:23:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:23:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:23:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:50 INFO - Downloading docopt-0.6.1.tar.gz 06:23:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:23:50 INFO - Installing collected packages: blobuploader, requests, docopt 06:23:50 INFO - Running setup.py install for blobuploader 06:23:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:23:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:23:50 INFO - Running setup.py install for requests 06:23:51 INFO - Running setup.py install for docopt 06:23:51 INFO - Successfully installed blobuploader requests docopt 06:23:51 INFO - Cleaning up... 06:23:51 INFO - Return code: 0 06:23:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:23:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:51 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 0x7fb29adecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1477790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1474930>, '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 0x1475830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1475cc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1475583495.835933-1480351109', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:23:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:23:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:23:51 INFO - Using env: {'DISPLAY': ':0', 06:23:51 INFO - 'HOME': '/home/cltbld', 06:23:51 INFO - 'LANG': 'en_US.UTF-8', 06:23:51 INFO - 'LANGUAGE': 'en_US:en', 06:23:51 INFO - 'LOGNAME': 'cltbld', 06:23:51 INFO - 'MAIL': '/var/mail/cltbld', 06:23:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:51 INFO - 'MOZ_NO_REMOTE': '1', 06:23:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:51 INFO - 'NO_EM_RESTART': '1', 06:23:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:51 INFO - 'PWD': '/builds/slave/test', 06:23:51 INFO - 'SHELL': '/bin/bash', 06:23:51 INFO - 'SHLVL': '1', 06:23:51 INFO - 'TERM': 'linux', 06:23:51 INFO - 'TMOUT': '86400', 06:23:51 INFO - 'USER': 'cltbld', 06:23:51 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1475583495.835933-1480351109', 06:23:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:51 INFO - '_': '/tools/buildbot/bin/python'} 06:23:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:23:51 INFO - Running setup.py (path:/tmp/pip-g5Ysc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:23:51 INFO - Running setup.py (path:/tmp/pip-f_moe5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:23:51 INFO - Running setup.py (path:/tmp/pip-10Lli2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:23:51 INFO - Running setup.py (path:/tmp/pip-ydyDkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:23:51 INFO - Running setup.py (path:/tmp/pip-KqEsiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:23:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:23:51 INFO - Running setup.py (path:/tmp/pip-IoZRW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:23:52 INFO - Running setup.py (path:/tmp/pip-Ldl8zA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:23:52 INFO - Running setup.py (path:/tmp/pip-a0__O_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:23:52 INFO - Running setup.py (path:/tmp/pip-zp4PRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:23:52 INFO - Running setup.py (path:/tmp/pip-lQKM9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:23:52 INFO - Running setup.py (path:/tmp/pip-kH0PZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:23:52 INFO - Running setup.py (path:/tmp/pip-9I9xXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:23:52 INFO - Running setup.py (path:/tmp/pip-PbDDfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:23:52 INFO - Running setup.py (path:/tmp/pip-T8z2f1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:23:52 INFO - Running setup.py (path:/tmp/pip-ti518m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:23:52 INFO - Running setup.py (path:/tmp/pip-jNnLpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:23:52 INFO - Running setup.py (path:/tmp/pip-ivk8vs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:23:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:23:52 INFO - Running setup.py install for manifestparser 06:23:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:23:52 INFO - Running setup.py install for mozcrash 06:23:53 INFO - Running setup.py install for mozdebug 06:23:53 INFO - Running setup.py install for mozdevice 06:23:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:23:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:23:53 INFO - Running setup.py install for mozfile 06:23:53 INFO - Running setup.py install for mozhttpd 06:23:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:23:53 INFO - Running setup.py install for mozinfo 06:23:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:23:53 INFO - Running setup.py install for mozInstall 06:23:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:23:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:23:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:23:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:23:53 INFO - Running setup.py install for mozleak 06:23:53 INFO - Running setup.py install for mozlog 06:23:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:23:53 INFO - Running setup.py install for moznetwork 06:23:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:23:54 INFO - Running setup.py install for mozprocess 06:23:54 INFO - Running setup.py install for mozprofile 06:23:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:23:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:23:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:23:54 INFO - Running setup.py install for mozrunner 06:23:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:23:54 INFO - Running setup.py install for mozscreenshot 06:23:54 INFO - Running setup.py install for moztest 06:23:54 INFO - Running setup.py install for mozversion 06:23:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:23:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:23:54 INFO - Cleaning up... 06:23:54 INFO - Return code: 0 06:23:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:54 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 0x7fb29adecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1477790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1474930>, '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 0x1475830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1475cc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1475583495.835933-1480351109', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:23:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:23:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:23:54 INFO - Using env: {'DISPLAY': ':0', 06:23:54 INFO - 'HOME': '/home/cltbld', 06:23:54 INFO - 'LANG': 'en_US.UTF-8', 06:23:54 INFO - 'LANGUAGE': 'en_US:en', 06:23:54 INFO - 'LOGNAME': 'cltbld', 06:23:54 INFO - 'MAIL': '/var/mail/cltbld', 06:23:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:54 INFO - 'MOZ_NO_REMOTE': '1', 06:23:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:54 INFO - 'NO_EM_RESTART': '1', 06:23:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:54 INFO - 'PWD': '/builds/slave/test', 06:23:54 INFO - 'SHELL': '/bin/bash', 06:23:54 INFO - 'SHLVL': '1', 06:23:54 INFO - 'TERM': 'linux', 06:23:54 INFO - 'TMOUT': '86400', 06:23:54 INFO - 'USER': 'cltbld', 06:23:54 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1475583495.835933-1480351109', 06:23:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:54 INFO - '_': '/tools/buildbot/bin/python'} 06:23:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:23:54 INFO - Running setup.py (path:/tmp/pip-BYpVYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:23:54 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:23:54 INFO - Running setup.py (path:/tmp/pip-5GPAgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:23:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:23:55 INFO - Running setup.py (path:/tmp/pip-iJV2dK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:23:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:23:55 INFO - Running setup.py (path:/tmp/pip-cuQMyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:23:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:23:55 INFO - Running setup.py (path:/tmp/pip-r2iPR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:23:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:23:55 INFO - Running setup.py (path:/tmp/pip-rTAwIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:23:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:23:55 INFO - Running setup.py (path:/tmp/pip-iFIQh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:23:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:23:55 INFO - Running setup.py (path:/tmp/pip-OfOgrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:23:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:23:55 INFO - Running setup.py (path:/tmp/pip-ra0aF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:23:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:23:55 INFO - Running setup.py (path:/tmp/pip-O0pzM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:23:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:23:55 INFO - Running setup.py (path:/tmp/pip-yHS8Gw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:23:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:23:55 INFO - Running setup.py (path:/tmp/pip-K8fBq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:23:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:23:55 INFO - Running setup.py (path:/tmp/pip-UdOfRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:23:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:23:55 INFO - Running setup.py (path:/tmp/pip-qRV2aL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:23:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:23:55 INFO - Running setup.py (path:/tmp/pip-z8P0ig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:23:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:23:56 INFO - Running setup.py (path:/tmp/pip-A3OcqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:23:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:23:56 INFO - Running setup.py (path:/tmp/pip-o0FMbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:23:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:23:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:23:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:23:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:23:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:23:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:23:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:58 INFO - Downloading blessings-1.6.tar.gz 06:23:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:23:58 INFO - Installing collected packages: blessings 06:23:58 INFO - Running setup.py install for blessings 06:23:58 INFO - Successfully installed blessings 06:23:58 INFO - Cleaning up... 06:23:58 INFO - Return code: 0 06:23:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:23:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:23:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:23:58 INFO - Reading from file tmpfile_stdout 06:23:58 INFO - Current package versions: 06:23:58 INFO - argparse == 1.2.1 06:23:58 INFO - blessings == 1.6 06:23:58 INFO - blobuploader == 1.2.4 06:23:58 INFO - docopt == 0.6.1 06:23:58 INFO - functools32 == 3.2.3-2 06:23:58 INFO - jsonschema == 2.5.1 06:23:58 INFO - manifestparser == 1.1 06:23:58 INFO - mozInstall == 1.12 06:23:58 INFO - mozcrash == 0.17 06:23:58 INFO - mozdebug == 0.1 06:23:58 INFO - mozdevice == 0.48 06:23:58 INFO - mozfile == 1.2 06:23:58 INFO - mozhttpd == 0.7 06:23:58 INFO - mozinfo == 0.9 06:23:58 INFO - mozleak == 0.1 06:23:58 INFO - mozlog == 3.4 06:23:58 INFO - moznetwork == 0.27 06:23:58 INFO - mozprocess == 0.23 06:23:58 INFO - mozprofile == 0.28 06:23:58 INFO - mozrunner == 6.12 06:23:58 INFO - mozscreenshot == 0.1 06:23:58 INFO - mozsystemmonitor == 0.3 06:23:58 INFO - moztest == 0.7 06:23:58 INFO - mozversion == 1.4 06:23:58 INFO - psutil == 3.1.1 06:23:58 INFO - requests == 1.2.3 06:23:58 INFO - wsgiref == 0.1.2 06:23:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:23:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:58 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 0x7fb29adecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1477790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1474930>, '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 0x1475830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1475cc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1475583495.835933-1480351109', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:23:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:23:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:23:58 INFO - Using env: {'DISPLAY': ':0', 06:23:58 INFO - 'HOME': '/home/cltbld', 06:23:58 INFO - 'LANG': 'en_US.UTF-8', 06:23:58 INFO - 'LANGUAGE': 'en_US:en', 06:23:58 INFO - 'LOGNAME': 'cltbld', 06:23:58 INFO - 'MAIL': '/var/mail/cltbld', 06:23:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:58 INFO - 'MOZ_NO_REMOTE': '1', 06:23:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:58 INFO - 'NO_EM_RESTART': '1', 06:23:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:58 INFO - 'PWD': '/builds/slave/test', 06:23:58 INFO - 'SHELL': '/bin/bash', 06:23:58 INFO - 'SHLVL': '1', 06:23:58 INFO - 'TERM': 'linux', 06:23:58 INFO - 'TMOUT': '86400', 06:23:58 INFO - 'USER': 'cltbld', 06:23:58 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1475583495.835933-1480351109', 06:23:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:58 INFO - '_': '/tools/buildbot/bin/python'} 06:23:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:23:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:23:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:23:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:23:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:23:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:23:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:23:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:23:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:23:58 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:23:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:23:58 INFO - Cleaning up... 06:23:58 INFO - Return code: 0 06:23:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:23:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:23:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:58 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 0x7fb29adecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1477790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1474930>, '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 0x1475830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1475cc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1475583495.835933-1480351109', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:23:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:23:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:23:58 INFO - Using env: {'DISPLAY': ':0', 06:23:58 INFO - 'HOME': '/home/cltbld', 06:23:58 INFO - 'LANG': 'en_US.UTF-8', 06:23:58 INFO - 'LANGUAGE': 'en_US:en', 06:23:58 INFO - 'LOGNAME': 'cltbld', 06:23:58 INFO - 'MAIL': '/var/mail/cltbld', 06:23:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:58 INFO - 'MOZ_NO_REMOTE': '1', 06:23:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:58 INFO - 'NO_EM_RESTART': '1', 06:23:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:58 INFO - 'PWD': '/builds/slave/test', 06:23:58 INFO - 'SHELL': '/bin/bash', 06:23:58 INFO - 'SHLVL': '1', 06:23:58 INFO - 'TERM': 'linux', 06:23:58 INFO - 'TMOUT': '86400', 06:23:58 INFO - 'USER': 'cltbld', 06:23:58 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1475583495.835933-1480351109', 06:23:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:58 INFO - '_': '/tools/buildbot/bin/python'} 06:23:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:23:59 INFO - Cleaning up... 06:23:59 INFO - Return code: 0 06:23:59 INFO - Running post-action listener: _resource_record_post_action 06:23:59 INFO - Running post-action listener: _start_resource_monitoring 06:23:59 INFO - Starting resource monitoring. 06:23:59 INFO - [mozharness: 2016-10-04 13:23:59.063946Z] Finished create-virtualenv step (success) 06:23:59 INFO - [mozharness: 2016-10-04 13:23:59.064463Z] Running install step. 06:23:59 INFO - Running pre-action listener: _resource_record_pre_action 06:23:59 INFO - Running main action method: install 06:23:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:23:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:23:59 INFO - Reading from file tmpfile_stdout 06:23:59 INFO - Detecting whether we're running mozinstall >=1.0... 06:23:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:23:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:23:59 INFO - Reading from file tmpfile_stdout 06:23:59 INFO - Output received: 06:23:59 INFO - Usage: mozinstall [options] installer 06:23:59 INFO - Options: 06:23:59 INFO - -h, --help show this help message and exit 06:23:59 INFO - -d DEST, --destination=DEST 06:23:59 INFO - Directory to install application into. [default: 06:23:59 INFO - "/builds/slave/test"] 06:23:59 INFO - --app=APP Application being installed. [default: firefox] 06:23:59 INFO - mkdir: /builds/slave/test/build/application 06:23:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:23:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:24:16 INFO - Reading from file tmpfile_stdout 06:24:16 INFO - Output received: 06:24:16 INFO - /builds/slave/test/build/application/firefox/firefox 06:24:16 INFO - Running post-action listener: _resource_record_post_action 06:24:16 INFO - [mozharness: 2016-10-04 13:24:16.384836Z] Finished install step (success) 06:24:16 INFO - [mozharness: 2016-10-04 13:24:16.385081Z] Running run-tests step. 06:24:16 INFO - Running pre-action listener: _resource_record_pre_action 06:24:16 INFO - Running main action method: run_tests 06:24:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:24:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:24:16 INFO - Python 2.7.3 06:24:16 INFO - Return code: 0 06:24:16 INFO - grabbing minidump binary from tooltool 06:24:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:24:16 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 0x1474930>, '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 0x1475830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1475cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:24:16 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:24:16 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:24:16 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:24:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:24:16 INFO - Return code: 0 06:24:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:24:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:24:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:24:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:24:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:24:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bMH63fvVSq2JtoPw78lB2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:24:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bMH63fvVSq2JtoPw78lB2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:24:16 INFO - Using env: {'DISPLAY': ':0', 06:24:16 INFO - 'HOME': '/home/cltbld', 06:24:16 INFO - 'LANG': 'en_US.UTF-8', 06:24:16 INFO - 'LANGUAGE': 'en_US:en', 06:24:16 INFO - 'LOGNAME': 'cltbld', 06:24:16 INFO - 'MAIL': '/var/mail/cltbld', 06:24:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:24:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:24:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:16 INFO - 'MOZ_NO_REMOTE': '1', 06:24:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:24:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:24:16 INFO - 'NO_EM_RESTART': '1', 06:24:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:24:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:16 INFO - 'PWD': '/builds/slave/test', 06:24:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:24:16 INFO - 'SHELL': '/bin/bash', 06:24:16 INFO - 'SHLVL': '1', 06:24:16 INFO - 'TERM': 'linux', 06:24:16 INFO - 'TMOUT': '86400', 06:24:16 INFO - 'USER': 'cltbld', 06:24:16 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1475583495.835933-1480351109', 06:24:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:16 INFO - '_': '/tools/buildbot/bin/python'} 06:24:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bMH63fvVSq2JtoPw78lB2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:24:16 INFO - mozversion application_buildid: 20161004033013 06:24:16 INFO - mozversion application_changeset: 1a5030f96cdb8ac74e44d8ba776633354d1fa428 06:24:16 INFO - mozversion application_display_name: Nightly 06:24:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:24:16 INFO - mozversion application_name: Firefox 06:24:16 INFO - mozversion application_remotingname: firefox 06:24:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 06:24:16 INFO - mozversion application_vendor: Mozilla 06:24:16 INFO - mozversion application_version: 52.0a1 06:24:16 INFO - mozversion platform_buildid: 20161004033013 06:24:16 INFO - mozversion platform_changeset: 1a5030f96cdb8ac74e44d8ba776633354d1fa428 06:24:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 06:24:16 INFO - mozversion platform_version: 52.0a1 06:24:16 INFO - using testdate: 1475587456 06:24:16 INFO - actual date: 1475587456 06:24:16 INFO - starting webserver on 'localhost:43558' 06:24:16 INFO - SUITE-START | Running 2 tests 06:24:16 INFO - TEST-START | dromaeo_css 06:24:16 INFO - operating with platform_type : linux_ 06:24:16 INFO - Initialising browser for dromaeo_css test... 06:24:16 INFO - TEST-INFO | started process 22114 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKL422X/profile http://localhost:43558/getInfo.html) 06:24:21 INFO - PROCESS | 22114 | __metrics Screen width/height:1600/1200 06:24:21 INFO - PROCESS | 22114 | colorDepth:24 06:24:21 INFO - PROCESS | 22114 | Browser inner width/height: 1024/697 06:24:21 INFO - PROCESS | 22114 | __metrics 06:24:21 INFO - PROCESS | 22114 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:24:21 INFO - PROCESS | 22114 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:24:22 INFO - PROCESS | 22114 | console.error: PushService: 06:24:22 INFO - PROCESS | 22114 | stateChangeProcessEnqueue: Error transitioning state 06:24:22 INFO - PROCESS | 22114 | UnknownError 06:24:23 INFO - TEST-INFO | 22114: exit 0 06:24:23 INFO - Browser initialized. 06:24:23 INFO - Running cycle 1/1 for dromaeo_css test... 06:24:23 INFO - TEST-INFO | started process 22196 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKL422X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:24:35 INFO - PROCESS | 22196 | RSS: Main: 174026752 06:24:35 INFO - PROCESS | 22196 | 06:25:26 INFO - PROCESS | 22196 | 1475587526832 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:27:36 INFO - PROCESS | 22196 | Cycle 1(1): loaded http://localhost:43558/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43558/tests/dromaeo/cssquery-ext.html) 06:27:39 INFO - PROCESS | 22196 | RSS: Main: 428769280 06:27:39 INFO - PROCESS | 22196 | 06:30:41 INFO - PROCESS | 22196 | Cycle 1(1): loaded http://localhost:43558/tests/dromaeo/cssquery-ext.html (next: http://localhost:43558/tests/dromaeo/cssquery-jquery.html) 06:30:42 INFO - PROCESS | 22196 | RSS: Main: 287158272 06:30:42 INFO - PROCESS | 22196 | 06:33:44 INFO - PROCESS | 22196 | Cycle 1(1): loaded http://localhost:43558/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43558/tests/dromaeo/cssquery-mootools.html) 06:33:45 INFO - PROCESS | 22196 | RSS: Main: 220033024 06:33:45 INFO - PROCESS | 22196 | 06:36:47 INFO - PROCESS | 22196 | Cycle 1(1): loaded http://localhost:43558/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43558/tests/dromaeo/cssquery-prototype.html) 06:36:47 INFO - PROCESS | 22196 | RSS: Main: 222535680 06:36:47 INFO - PROCESS | 22196 | 06:39:50 INFO - PROCESS | 22196 | Cycle 1(1): loaded http://localhost:43558/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43558/tests/dromaeo/cssquery-yui.html) 06:39:50 INFO - PROCESS | 22196 | RSS: Main: 221896704 06:39:50 INFO - PROCESS | 22196 | 06:42:53 INFO - PROCESS | 22196 | Cycle 1(1): loaded http://localhost:43558/tests/dromaeo/cssquery-yui.html (next: http://localhost:43558/tests/dromaeo/cssquery-dojo.html) 06:42:54 INFO - PROCESS | 22196 | RSS: Main: 310992896 06:42:54 INFO - PROCESS | 22196 | 06:42:54 INFO - PROCESS | 22196 | __start_tp_report 06:42:54 INFO - PROCESS | 22196 | _x_x_mozilla_page_load 06:42:54 INFO - PROCESS | 22196 | _x_x_mozilla_page_load_details 06:42:54 INFO - PROCESS | 22196 | |i|pagename|runs| 06:42:54 INFO - PROCESS | 22196 | |0;dojo.html;2975.8958436454723;3009.3830764693234;3011.9548206776903;3042.54361845723;3052.587900633414;5036.6222533309965;5074.847754567364;5106.897862042757;5127.461616530267;5164.715940623264;5100.336956195699;5119;5123.487651234875;5133.691978481284;5140.126178549646;4710.623150147997;4775.761211939398;4776.761161941907;4780.354652121971;4784.688995215317;4672.532746725335;4794.808207671689;4811.278308253755;4836.613070954333;4902.313676085351;4768.117898188829;4768.833090841821;4795.136875362434;4820.156472617296;4877.02459508098;4568.634509239286;4581.037982023779;4612.446506419217;4762.857114286577;4777.641676874248;4618.56123668251;4634.83778067766;4644.187267228222;4666.859994200179;4730.101280756679;5047.722375269359;5052.216906379517;5055.595552355802;5074.619403544712;5133.281340612317;5304.310439642822;5446.700431476267;5453.863653408657;5465.098258787335;5466.890662186774;5369.060414427459;5495.780168793243;5528.308961379827;5547.944520554784;5636.15457681347;5199.064168449678;5210.088234559013;5210.478952104835;5210.609204309692;5213.921791173136;5654.6889921054735;5655.5475561954945;5658.91511627326;5661.603687741818;5729.942700572941;5298.735063246822;5338.893222135535;5380.166074258496;5411.783528658888;5426.701531415731;5495.120780675073;5500.834974950758;5506.03644362243;5536.695481748462;5572.3034620672415;5435.266239057755;5450.836474905759;5476.452354764491;5495.258140151109;5504.91742623861;5350.732463376893;5429.022775900376;5431.456854314537;5507.7246137692955;5564.471375219428;4184.5187803403;4204.8528301509305;4220.915581688349;4223.092035212444;4271.060366719316;3750.9062273442837;3755.136318646672;3756.248750249906;3792.469054332396;3797.430385442206;5122.282880396748;5175.896482070413;5178.559822415062;5183.559397451183;5245.213218017251;5405.972970135124;5500.889982200333;5581.386047534768;5590.24531688225;5601.047821870292;5238.947610523922;5255.185446255837;5260.947390526046;5262.342207224097;5266.1574148136115;4778.522147785194;4810.470848206694;4814.831480898151;4818;4856.878578035577;5521.834344969658;5610.775568977277;5616.045272303718;5632.380438151882;5703.686297253691;5442.401335852974;5447.863803404946;5451.591130665295;5452.591055670761;5458.6724796512335;5691.402402747652;5693.516051135534;5693.857653558529;5702.942970570407;5706.4864162225595;5319.654222475527;5347.812826551052;5355.544778693855;5362.061639213044;5365.409804921534;5463.836084917459;5467.261919640798;5471.151971444432;5474.589405794661;5476.753546090516;5307.283516725347;5329;5330.600204984719;5333.573314134937;5333.78664853417;5323.0684630190335;5325.440828712929;5331.306930099062;5352.785888564569;5396.487333703292;5376.731163441734;5382;5388.488093631099;5389.27244821944;5451.64564303319;5215.973920130375;5245.763940622604;5350;5392.083345831296;5418.241446197457;5230.2677625131755;5270.130428479411;5276.023935571931;5323.653962492581;5329.413764485826 06:42:54 INFO - PROCESS | 22196 | |1;ext.html;571.3429556010587;594.9405059494054;603.6589327030227;605.9787907423241;606.4178388746802;32820.83589582055;43985.56014439854;45302.32046519305;45515.089698206015;48453.75773121129;46717;47097.29354059692;47168.764156179255;47202;47292.290615640704;8968.013518512975;9123.726288211365;9124.954375228115;9125.49809760463;9128.680496182635;8250.46371985822;8444.831103377928;10760;11006.119510439146;11006.504707288152;11167.83248251277;11278.605248816293;11282.435878206097;11285.943570282137;11287.943560282187;11059.281146725438;11117.999380055793;11124.221304508688;11129.387883666395;11137.443127843575;10856.837147442795;10934.835977460345;10938.343699378063;10945.23383363165;10948.3978381189;43508.56491435077;43604.56395436037;43805;44004;44006.339904901455;3435.7594968351978;3449.6205417404067;3468.3756923753713;3469.65303469651;3497.8600855965733;31790.682093179003;31878.681213187803;32360.838195809105;32474;32514.674853251403;4307.633851122659;4449.599536041772;4454.665900057508;4490.169318676056;4536.7504787236685;329617;332475;332783;333712.3314383437;334002;59610.70194648999;59820.70089649524;59898.01529770569;60028.39971600316;60355;60733;60746;65208;65282.67358663176;65588.67205664037;17203.65592688139;17472.990606080464;17475.300987960338;17480.65038699244;17484.65030699379;12060.336681482428;12311.753764924651;13206.537771177962;13357.198568085945;13379;19562.21751129939;20160.49598760043;20282.797172028386;20756.377308680763;20893.582128357346;7332.156801967735;7389.8152546186775;7519.360854327334;7546.169921308651;7701.614919254127;959.8848138223458;1029.5727273181697;1064.892511787732;1066.2642776484201;1088.77135801481;32698;32851.1787205317;32956;32971.50542741813;33039.3392132156;1068.6206396729206;1076.967690969272;1125.8363997167985;1144.8797876223043;1165.2309475745967;16779.496615101565;17376.306672465787;17427.73858392125;17542;17610;476586;489971;490976;492711;495104;59992.400075999554;60214.39785602088;60216.397836021955;60494.395056049754;60528.69735651294;1216.7079900823915;1269.2765123879485;1347.508159521787;1366.658335416146;1389.0832050846595;30160;32775.34449310953;33876.83061584676;34640.480392794634;36923.63076369202;55355.72322138525;56505;56575.60546367231;61636;61702.38297616966;433600;441276;441908;443464;445654.5759068148;44841;45897.31154032626;46008;46725.53274467212;48577.75711121422;50242.24636630381;50320.496795031584;51029.489705102475;51065.48934510607;51262.48737512726;41780.791096044326;42958;43203;43256;45185.548144519445;42036;42207.577924221594;42968.35547466728;42999.14001720011;44394;41491.7925410371;42325.36511952385;42682;43035.569644303156;43231.78384108059;35846.46230306599;37759.43360849535;38214;39100.608993910835;39158.80420597879;28336.85831570829;28825.855870720512;29016.419671606873;29146.41707165887;30075 06:42:54 INFO - PROCESS | 22196 | |2;jquery.html;364.965328293812;377.7185996432658;388.1790014120136;393.1213737297141;417.0803378550297;13903.44386224551;14059.196096310716;15414.922925385357;17668.558286042855;17756.46730598081;18575.164117614706;19080.522986925298;19404.90297548514;19508;19650.803491965074;5460.099083651193;5684.54523638108;5693.060644993571;5696.943030569703;5700.6579605223615;5372.597055220874;5544.695041772701;5577.079781835992;5582.7766889324375;5603.915941260884;5506.146547285177;5549.556035517149;5555.555555555546;5561.360443549003;5564.054110801174;5313.335833020872;5461.726913654321;5481.561475081984;5491.835244942658;5495.120780675113;4900.215965445547;4904.288878112689;4909.042736666352;4912.38595175603;4912.606991440676;21484.248051318285;22014.669779953314;22271.55456890853;22457.775422245733;22600.095996160133;2135.011908135806;2241.932742017742;2403.807695384365;2486.502699460097;2632.6445929799424;10082.344647597884;10271.435071071088;10581.84127238092;10679.626213082582;10882.455877206108;1838.4208974173227;1865.291189348039;1890.971635425456;1893.7159426086198;1904.3430016644375;80767;84547;84974;85413.57293213556;88295.55852220762;10406.323588966692;10507.527161277761;10992.395418251914;11025.967858838883;11291.49188286529;15227.238638068053;15241.390344386322;15241.771373429407;15257.465988690343;15266.16036118002;8008.599570021475;8064.395170362129;8090.514569125871;8296.958515207507;8312.625931833081;7811.101723301779;7813.609319534001;8055.113937466874;8065.919340806634;8084.151164127799;4473.865784026484;4607.746573938399;4651.697639653412;4711.340412342275;4872.78072486739;1970.3694817658497;2008.5279959209574;2023.1806118522022;2024.3724445421967;2067.441790716498;925.1765928323797;939.5818860606964;947.9431234125974;1006.4716024087413;1015.2487159501916;17618;19688.507787305145;19756.802431975495;19778.208871644973;19942.1026053825;960.188640598693;960.9519524023771;1012.8176928152856;1013.6502906497246;1026.2610920137488;10573.735656608646;10992.945035274932;11050.171237157085;11051.226414150933;11101.944490277498;431232;433218;434821;437165;438919.8864090865;86687;87325.56337218273;87839;89304.23164360084;91605.5419722897;942.8632848237104;943.8112377524523;960.8991055939166;960.9519524023771;977.4672803322206;16750.832491674926;17045;17454;17571.736423953906;17699.20353584066;42796.572034279256;43157.56842431535;43274.13451730885;43275.35086973635;44538.3319250218;57999.71000145141;58092.19078092326;59448.108278374995;59908.70045649744;60160.39839601548;8093.433459657767;8328.541930193898;8331.6667333306;8429.915700843158;8457.957710211409;12228.082893782825;12256.448459819509;12280.201786883825;12461.87538124607;12610.18033827835;10679.89320106789;10882.12942964545;10906.945465272624;11248.606298779503;11753.764924701287;10725.356478611307;10767.825318616793;10867.29362591429;11141.275817071864;11296;11061;11542.94228528852;11587.594434194763;11700.47347869365;11819.231749936227;6788.626625535643;7327.413806895543;7367.742129025459;7649.349805266615;8761.080086591071;10889.509972051435;10940;10991.560337586407;11392.25950313227;11698.532058717556 06:42:54 INFO - PROCESS | 22196 | |3;mootools.html;1347.8180445639837;1456.9927150364247;1494.8654621084102;1586.7619857021446;1756.947291581253;7305.342519173273;7820.7653770386905;8590.26982706469;8841.778955526099;8863.379563430562;8636.654533818655;8717.21545060946;8735.126487351261;8737.868931966026;8744.125587441253;2313.6066868632374;2322.686437330964;2350.3654013416367;2351.6002279612508;2354.564405584972;2254.402583315423;2305.0203663443053;2336.5816380046654;2345.589521833681;2346.6975828415225;2311.2719493359623;2311.514581937795;2339.099446713011;2350.0247397330086;2357.045396614374;2251.268337790225;2253.3915842722454;2254.7745225477483;2261.344210179046;2261.9934129312464;2233.932982010542;2237.1498830444325;2237.876916769577;2240.19353032908;2243.1588154442084;8496.957515212385;8527.872081918777;8584.31325493959;8619.741407757714;8620.65517379304;5099.821506247301;5276;5389.946100538984;5408.91886621701;5424.83725488232;3289.555909952174;3417.5898892133105;3468.6011108722314;3482.2861313430685;3496.4405695088917;941.7928055827707;971.7376308396694;985.6944347252303;992.4640694025218;994.2443742755557;11752.588659396966;11834.112441566916;11857.703557411047;11901.821472678002;11975.922167004925;4398;4531.796069176895;4601.102784956901;4678.742669153161;4682.578567928835;9330.066993300616;9338.57976391064;9339.533023348806;9341.626334946663;9343.672971445967;5231.215317702375;5246.422893481714;5248.921266181011;5249.2126181073145;5251.737413129328;4195.748255104703;4316;4718.268668356342;4856.125897338513;4923.926141107886;3648.835802388899;3680.5215322008503;3758.962410375916;3798.240351929625;3861.0733423978604;1141.531971891537;1142.7714457108611;1144.5135817277624;1156.2831044752306;1165.81929800881;785.9724909628136;839.2782207301716;947.5499137909438;950.4297421547017;999.8250306196387;5333.466653334713;5517.310336207974;5565.833025009175;5675.233843431084;5979.910301345483;481.92048312028123;490.45069522135435;495.10633306880703;501.98494045178705;659.1661548141604;3764.3036038333;3911.8435262589746;3916.138449541096;3932.6853851692367;4022.1955608878343;10155;10489.632862849763;10524.31591946521;10524.421156836448;10530.262881598215;10454.163666906628;10651.094656954245;10765;10771.461426928623;10771.676849694522;7777.455578109478;7818.726344578026;7861.174576669482;7942.324902383362;7950.840983180419;5516.641418307797;5531.778728850962;5545.694986775766;5744.913826292525;5760.130029088202;9323.580438880132;9411.341206115507;9434.81130377375;9495.43027418357;9552.85670714926;9966.252531060345;10056.396616203052;10069.798604028025;10076.94961525217;10077.496125193858;7049.7885063448175;7129.108861392326;7131.25121862197;7133.714651414093;7137.928620713934;8149.144339844231;8165.305948994402;8219.465734727224;8233.629486672995;8271.131531189138;7033.683484243324;7048.929510705032;7094.787156385317;7512.962435187789;7539.773806785805;7364.3372096511575;7413.332800048021;7418.48070635072;7559.622018898923;7600;6701.195856497252;6771.6614169292325;6809.38715515606;6867.553609015398;6916.997035429935;4753.500882407436;4810.062037902575;4828.420589529139;4884.12085824555;4952.975235123801;4591.908161836812;4807.975960120177;4818.229083346788;4948.505149485167;4985.850424487271 06:42:54 INFO - PROCESS | 22196 | |4;prototype.html;314.9779515433919;323.7798297157933;337.71631829263424;338.20015662957104;348.01338206185466;4934.6299027572895;5099.286099946006;5166.416791604198;5168.457311982244;5219.086659834528;4978.751062446872;5097.668651537648;5103.974480127604;5113.539781419671;5127.231674542674;4067.0849058961644;4071.4503542021744;4076.2051399977017;4093.6520395766397;4101.52832424272;3937.2912875682364;4064.796760161995;4089.3048181809013;4102.261592913274;4130.297849365615;4038.7374820636564;4066.32905570582;4067.5932406759384;4085.9795701021453;4095.2219078375015;4030.355143177107;4040;4061;4070.206309769596;4076.9184616307803;3639.581448133472;3652.6164752701116;3660.158163622382;3661.9450708239397;3668.7615305005356;4824.807007719687;4999.975000124976;5019.4227663818765;5070.822521211777;5084.949150508522;4580.404547408815;4580.610648094916;4580.702254353457;4580.900583859883;4611.677182597219;5383.327084114486;5392.703401312926;5396.703181325026;5444.727763611843;5471.50756431923;3832.789196594214;3932.5477570079233;3980.1840622672285;4033.2941735196223;4061.370487574401;5502.889942201174;5547.944520554784;5560.36055853578;5563.193336966157;5582.609217354787;4115.36211887158;4135.110951145518;4155.4182414462;4158;4165.812538435777;4029.959700403017;4159.1265834175165;4205.705600607989;4207.768572728468;4214.431051808028;4694.694844835075;4701.670883038223;4710.199266124767;4732.455767586703;4735.479097299294;5326.440723723953;5401.810936617199;5423.29497165366;5427.592930530147;5436.238926550207;1354.7696891528267;1360.7482615716124;1377.8139951106673;1389.451166789133;1422.267532220907;921.8340698674303;939.4504215034145;945.9668911588061;952.4333021851987;969.9951500242595;4656.394668693116;4674.906501869944;4675.95324046762;4684.6486513510945;4703.670743047954;4844.927326090112;4860.3195552622665;4863.927041094386;4864.708117512961;4875.7074575524875;4622.907541849144;4630.398048253773;4636.744979026186;4667.649926255544;4668.883277918079;2739.8082134250412;2934.7967333393635;2947.852607369623;2960.955585666217;2962.244627619943;5812.6630874898165;5813.273340832396;5822.417758224228;5824.155497452845;5827.533797296206;5514.310711161105;5672.716364181774;5672.744726487318;5699.430056994351;5737.356778445717;5782.45066718661;5793.102069179284;5794.82615521535;5805.593608447452;5823.417658234142;5558.333000039859;5558.471945165203;5567.498925096761;5568.220449137043;5588.30146231721;5283.973580132075;5462.016836969384;5478.890422191614;5498.890022199614;5510.724463776875;5750.741216645178;5786.3056433228285;5808.477237048517;5812.21535092757;5891.3224979127945;3796.6013568574904;3982.143839074613;3989.740666856645;3997.620226078518;4009.7594144351433;5265.368155821326;5507.614466987273;5546.251256080377;5548.528375088163;5556.694381809039;5251.186066159751;5296.947030529799;5370.9731451342495;5404.216388623706;5452.209429632601;5390.4879036491475;5417.106177480671;5455.563554915677;5461.426550212171;5473.425290344616;5311.707856067799;5406.324209473816;5433.9184912225555;5434.559841642047;5446.727663616724;5463.890722185613;5464.699441530754;5464.9453505464435;5480.492864462305;5487.972560137174;5305.814296499604;5318.175682769177;5348.465153484621;5351.117065684119;5370.865728356823 06:42:54 INFO - PROCESS | 22196 | |5;yui.html;754.1252147508891;754.826389930316;758.2038859197844;786.4612740272913;835.6907944060697;15838.84161158388;16115.677686446294;16149.354025838982;16438.424655137074;16483.34066637333;16478.7528187077;16553.917230413863;16594.83405165948;16607.66784664306;16608.66782664346;669.8928171492562;813.7396033269356;825.628467189764;826.1738261738262;827.3050637464529;683.0505597219868;801.5511313664366;810.2707563193114;824.2499325613662;824.4558591329694;846.1073567386405;846.8137009857821;851.9446235994641;852.6291063387415;853.4367317570404;693.1508901595555;846.1622993236713;846.3736834742308;847.0851480401152;849.5794581682076;522.5088416888113;614.0727501472763;620.695859029077;631.2803404119308;632.4213344789512;14465.421383144767;14474.42102315906;14501.927490362586;14515.201663908481;14523.636909077251;12411.813822792665;12655.683607909783;12773.680657983532;12785.479007652586;12877.806832897513;12937.805932911015;12994.425863991082;13030.15304005246;13241.801372979413;13264.020793761929;4382.452193475816;4402.119576084764;4445.466544014706;4456.8885777855485;4557.772111394417;80801.59599202026;81149.59425202895;83417.16582834155;85258.14741852564;85360.71958920683;11346.482590397003;11379.203455758183;11388.544458221744;11473.426328683532;11569.967064326876;21067.157313707587;21111.155553777982;21136.471588210417;21144.154233830475;21157.365279041653;8173.386995975326;8373.455725377831;8513.14868513156;8525.658973640984;8704.518192722835;4629.467611224685;4660.510646382081;4682.601978831837;4687.343771871872;4775.617950563947;3322.700956913841;3426.1777173478185;3437.5187473753695;3444.121748954001;3444.2594842109065;637.2384999925138;649.1560970738021;654.0679531667355;655.4919937048825;660.6993817812884;542.1840130603416;658.3285049249835;666.8632930249287;675.5912672832866;681.7647911470535;9240.3526578701;9652.855207171899;9666.178374838217;9854.162396196403;9955.153811925922;656.3338211715113;668.3758466925418;672.3847679373318;676.8477092654114;699.78656509765;4499.6785943861205;4624.098300831373;4636.211843986531;4687.156311863897;4711.293306004127;68109.65945170242;68499;92299.53850230706;97327.51336243273;98583;92934.53532732428;93851.53074234721;94091.52954235185;95190;95446;80572.19427805647;80578;80697.19302806897;81157;83113;9098.408603440756;9393.29550283745;9452.43285402878;9707.951460242653;10188.439635820101;44574.777126115456;47644.7617761909;49774;49775.25337120018;51286;47138.76430617825;59162.40837591569;60720;69366;70099.64950175217;12477.625671229878;12526.749465010831;12956.352182390654;13509.256990865597;13830.930845345709;13938;14144.22206778637;14538.273086345853;14562.854371456573;14710.749586284857;12604.495820167458;12908.16096953695;13140.868591313965;14015.929920350332;14368.568942931728;12476.937615311865;12913.289769062792;13200.933995329962;13317.533886313933;13321.533746318832;13479.46082156742;13506.392212350664;13653.590392288248;13838.515651952133;14384.856151438351;10645.840312395476;10871.510782014986;11048.779024419628;11625.593104241649;11730.824037639613;10600.46997650099;11163.944180279046;11326.716832079264;11447.713807154554;11463.770724585629 06:42:54 INFO - PROCESS | 22196 | __end_tp_report 06:42:54 INFO - PROCESS | 22196 | __start_cc_report 06:42:54 INFO - PROCESS | 22196 | _x_x_mozilla_cycle_collect,2690 06:42:54 INFO - PROCESS | 22196 | __end_cc_report 06:42:54 INFO - PROCESS | 22196 | __startTimestamp1475588574197__endTimestamp 06:42:54 INFO - PROCESS | 22196 | 06:42:54 INFO - PROCESS | 22196 | ------- Summary: start ------- 06:42:54 INFO - PROCESS | 22196 | Number of tests: 6 06:42:54 INFO - PROCESS | 22196 | 06:42:54 INFO - PROCESS | 22196 | [#0] dojo.html Cycles:165 Average:5112.27 Median:5307.28 stddev:559.84 (10.5%) stddev-sans-first:535.88 06:42:54 INFO - PROCESS | 22196 | Values: 2975.9 3009.4 3012.0 3042.5 3052.6 5036.6 5074.8 5106.9 5127.5 5164.7 5100.3 5119.0 5123.5 5133.7 5140.1 4710.6 4775.8 4776.8 4780.4 4784.7 4672.5 4794.8 4811.3 4836.6 4902.3 4768.1 4768.8 4795.1 4820.2 4877.0 4568.6 4581.0 4612.4 4762.9 4777.6 4618.6 4634.8 4644.2 4666.9 4730.1 5047.7 5052.2 5055.6 5074.6 5133.3 5304.3 5446.7 5453.9 5465.1 5466.9 5369.1 5495.8 5528.3 5547.9 5636.2 5199.1 5210.1 5210.5 5210.6 5213.9 5654.7 5655.5 5658.9 5661.6 5729.9 5298.7 5338.9 5380.2 5411.8 5426.7 5495.1 5500.8 5506.0 5536.7 5572.3 5435.3 5450.8 5476.5 5495.3 5504.9 5350.7 5429.0 5431.5 5507.7 5564.5 4184.5 4204.9 4220.9 4223.1 4271.1 3750.9 3755.1 3756.2 3792.5 3797.4 5122.3 5175.9 5178.6 5183.6 5245.2 5406.0 5500.9 5581.4 5590.2 5601.0 5238.9 5255.2 5260.9 5262.3 5266.2 4778.5 4810.5 4814.8 4818.0 4856.9 5521.8 5610.8 5616.0 5632.4 5703.7 5442.4 5447.9 5451.6 5452.6 5458.7 5691.4 5693.5 5693.9 5702.9 5706.5 5319.7 5347.8 5355.5 5362.1 5365.4 5463.8 5467.3 5471.2 5474.6 5476.8 5307.3 5329.0 5330.6 5333.6 5333.8 5323.1 5325.4 5331.3 5352.8 5396.5 5376.7 5382.0 5388.5 5389.3 5451.6 5216.0 5245.8 5350.0 5392.1 5418.2 5230.3 5270.1 5276.0 5323.7 5329.4 06:42:54 INFO - PROCESS | 22196 | 06:42:54 INFO - PROCESS | 22196 | [#1] ext.html Cycles:180 Average:60292.22 Median:42121.79 stddev:112357.56 (266.7%) stddev-sans-first:112583.28 06:42:54 INFO - PROCESS | 22196 | Values: 571.3 594.9 603.7 606.0 606.4 32820.8 43985.6 45302.3 45515.1 48453.8 46717.0 47097.3 47168.8 47202.0 47292.3 8968.0 9123.7 9125.0 9125.5 9128.7 8250.5 8444.8 10760.0 11006.1 11006.5 11167.8 11278.6 11282.4 11285.9 11287.9 11059.3 11118.0 11124.2 11129.4 11137.4 10856.8 10934.8 10938.3 10945.2 10948.4 43508.6 43604.6 43805.0 44004.0 44006.3 3435.8 3449.6 3468.4 3469.7 3497.9 31790.7 31878.7 32360.8 32474.0 32514.7 4307.6 4449.6 4454.7 4490.2 4536.8 329617.0 332475.0 332783.0 333712.3 334002.0 59610.7 59820.7 59898.0 60028.4 60355.0 60733.0 60746.0 65208.0 65282.7 65588.7 17203.7 17473.0 17475.3 17480.7 17484.7 12060.3 12311.8 13206.5 13357.2 13379.0 19562.2 20160.5 20282.8 20756.4 20893.6 7332.2 7389.8 7519.4 7546.2 7701.6 959.9 1029.6 1064.9 1066.3 1088.8 32698.0 32851.2 32956.0 32971.5 33039.3 1068.6 1077.0 1125.8 1144.9 1165.2 16779.5 17376.3 17427.7 17542.0 17610.0 476586.0 489971.0 490976.0 492711.0 495104.0 59992.4 60214.4 60216.4 60494.4 60528.7 1216.7 1269.3 1347.5 1366.7 1389.1 30160.0 32775.3 33876.8 34640.5 36923.6 55355.7 56505.0 56575.6 61636.0 61702.4 433600.0 441276.0 441908.0 443464.0 445654.6 44841.0 45897.3 46008.0 46725.5 48577.8 50242.2 50320.5 51029.5 51065.5 51262.5 41780.8 42958.0 43203.0 43256.0 45185.5 42036.0 42207.6 42968.4 42999.1 44394.0 41491.8 42325.4 42682.0 43035.6 43231.8 35846.5 37759.4 38214.0 39100.6 39158.8 28336.9 28825.9 29016.4 29146.4 30075.0 06:42:54 INFO - PROCESS | 22196 | 06:42:54 INFO - PROCESS | 22196 | [#2] jquery.html Cycles:180 Average:27301.04 Median:371.34 stddev:72147.81 (19428.9%) stddev-sans-first:72321.86 06:42:54 INFO - PROCESS | 22196 | Values: 365.0 377.7 388.2 393.1 417.1 13903.4 14059.2 15414.9 17668.6 17756.5 18575.2 19080.5 19404.9 19508.0 19650.8 5460.1 5684.5 5693.1 5696.9 5700.7 5372.6 5544.7 5577.1 5582.8 5603.9 5506.1 5549.6 5555.6 5561.4 5564.1 5313.3 5461.7 5481.6 5491.8 5495.1 4900.2 4904.3 4909.0 4912.4 4912.6 21484.2 22014.7 22271.6 22457.8 22600.1 2135.0 2241.9 2403.8 2486.5 2632.6 10082.3 10271.4 10581.8 10679.6 10882.5 1838.4 1865.3 1891.0 1893.7 1904.3 80767.0 84547.0 84974.0 85413.6 88295.6 10406.3 10507.5 10992.4 11026.0 11291.5 15227.2 15241.4 15241.8 15257.5 15266.2 8008.6 8064.4 8090.5 8297.0 8312.6 7811.1 7813.6 8055.1 8065.9 8084.2 4473.9 4607.7 4651.7 4711.3 4872.8 1970.4 2008.5 2023.2 2024.4 2067.4 925.2 939.6 947.9 1006.5 1015.2 17618.0 19688.5 19756.8 19778.2 19942.1 960.2 961.0 1012.8 1013.7 1026.3 10573.7 10992.9 11050.2 11051.2 11101.9 431232.0 433218.0 434821.0 437165.0 438919.9 86687.0 87325.6 87839.0 89304.2 91605.5 942.9 943.8 960.9 961.0 977.5 16750.8 17045.0 17454.0 17571.7 17699.2 42796.6 43157.6 43274.1 43275.4 44538.3 57999.7 58092.2 59448.1 59908.7 60160.4 8093.4 8328.5 8331.7 8429.9 8458.0 12228.1 12256.4 12280.2 12461.9 12610.2 10679.9 10882.1 10906.9 11248.6 11753.8 10725.4 10767.8 10867.3 11141.3 11296.0 11061.0 11542.9 11587.6 11700.5 11819.2 6788.6 7327.4 7367.7 7649.3 8761.1 10889.5 10940.0 10991.6 11392.3 11698.5 06:42:54 INFO - PROCESS | 22196 | 06:42:54 INFO - PROCESS | 22196 | [#3] mootools.html Cycles:180 Average:5567.62 Median:4969.41 stddev:3170.94 (63.8%) stddev-sans-first:3163.98 06:42:54 INFO - PROCESS | 22196 | Values: 1347.8 1457.0 1494.9 1586.8 1756.9 7305.3 7820.8 8590.3 8841.8 8863.4 8636.7 8717.2 8735.1 8737.9 8744.1 2313.6 2322.7 2350.4 2351.6 2354.6 2254.4 2305.0 2336.6 2345.6 2346.7 2311.3 2311.5 2339.1 2350.0 2357.0 2251.3 2253.4 2254.8 2261.3 2262.0 2233.9 2237.1 2237.9 2240.2 2243.2 8497.0 8527.9 8584.3 8619.7 8620.7 5099.8 5276.0 5389.9 5408.9 5424.8 3289.6 3417.6 3468.6 3482.3 3496.4 941.8 971.7 985.7 992.5 994.2 11752.6 11834.1 11857.7 11901.8 11975.9 4398.0 4531.8 4601.1 4678.7 4682.6 9330.1 9338.6 9339.5 9341.6 9343.7 5231.2 5246.4 5248.9 5249.2 5251.7 4195.7 4316.0 4718.3 4856.1 4923.9 3648.8 3680.5 3759.0 3798.2 3861.1 1141.5 1142.8 1144.5 1156.3 1165.8 786.0 839.3 947.5 950.4 999.8 5333.5 5517.3 5565.8 5675.2 5979.9 481.9 490.5 495.1 502.0 659.2 3764.3 3911.8 3916.1 3932.7 4022.2 10155.0 10489.6 10524.3 10524.4 10530.3 10454.2 10651.1 10765.0 10771.5 10771.7 7777.5 7818.7 7861.2 7942.3 7950.8 5516.6 5531.8 5545.7 5744.9 5760.1 9323.6 9411.3 9434.8 9495.4 9552.9 9966.3 10056.4 10069.8 10076.9 10077.5 7049.8 7129.1 7131.3 7133.7 7137.9 8149.1 8165.3 8219.5 8233.6 8271.1 7033.7 7048.9 7094.8 7513.0 7539.8 7364.3 7413.3 7418.5 7559.6 7600.0 6701.2 6771.7 6809.4 6867.6 6917.0 4753.5 4810.1 4828.4 4884.1 4953.0 4591.9 4808.0 4818.2 4948.5 4985.9 06:42:54 INFO - PROCESS | 22196 | 06:42:54 INFO - PROCESS | 22196 | [#4] prototype.html Cycles:180 Average:4538.74 Median:5077.89 stddev:1317.40 (25.9%) stddev-sans-first:1282.39 06:42:54 INFO - PROCESS | 22196 | Values: 315.0 323.8 337.7 338.2 348.0 4934.6 5099.3 5166.4 5168.5 5219.1 4978.8 5097.7 5104.0 5113.5 5127.2 4067.1 4071.5 4076.2 4093.7 4101.5 3937.3 4064.8 4089.3 4102.3 4130.3 4038.7 4066.3 4067.6 4086.0 4095.2 4030.4 4040.0 4061.0 4070.2 4076.9 3639.6 3652.6 3660.2 3661.9 3668.8 4824.8 5000.0 5019.4 5070.8 5084.9 4580.4 4580.6 4580.7 4580.9 4611.7 5383.3 5392.7 5396.7 5444.7 5471.5 3832.8 3932.5 3980.2 4033.3 4061.4 5502.9 5547.9 5560.4 5563.2 5582.6 4115.4 4135.1 4155.4 4158.0 4165.8 4030.0 4159.1 4205.7 4207.8 4214.4 4694.7 4701.7 4710.2 4732.5 4735.5 5326.4 5401.8 5423.3 5427.6 5436.2 1354.8 1360.7 1377.8 1389.5 1422.3 921.8 939.5 946.0 952.4 970.0 4656.4 4674.9 4676.0 4684.6 4703.7 4844.9 4860.3 4863.9 4864.7 4875.7 4622.9 4630.4 4636.7 4667.6 4668.9 2739.8 2934.8 2947.9 2961.0 2962.2 5812.7 5813.3 5822.4 5824.2 5827.5 5514.3 5672.7 5672.7 5699.4 5737.4 5782.5 5793.1 5794.8 5805.6 5823.4 5558.3 5558.5 5567.5 5568.2 5588.3 5284.0 5462.0 5478.9 5498.9 5510.7 5750.7 5786.3 5808.5 5812.2 5891.3 3796.6 3982.1 3989.7 3997.6 4009.8 5265.4 5507.6 5546.3 5548.5 5556.7 5251.2 5296.9 5371.0 5404.2 5452.2 5390.5 5417.1 5455.6 5461.4 5473.4 5311.7 5406.3 5433.9 5434.6 5446.7 5463.9 5464.7 5464.9 5480.5 5488.0 5305.8 5318.2 5348.5 5351.1 5370.9 06:42:54 INFO - PROCESS | 22196 | 06:42:54 INFO - PROCESS | 22196 | [#5] yui.html Cycles:180 Average:19465.25 Median:25925.03 stddev:26711.59 (103.0%) stddev-sans-first:26749.57 06:42:54 INFO - PROCESS | 22196 | Values: 754.1 754.8 758.2 786.5 835.7 15838.8 16115.7 16149.4 16438.4 16483.3 16478.8 16553.9 16594.8 16607.7 16608.7 669.9 813.7 825.6 826.2 827.3 683.1 801.6 810.3 824.2 824.5 846.1 846.8 851.9 852.6 853.4 693.2 846.2 846.4 847.1 849.6 522.5 614.1 620.7 631.3 632.4 14465.4 14474.4 14501.9 14515.2 14523.6 12411.8 12655.7 12773.7 12785.5 12877.8 12937.8 12994.4 13030.2 13241.8 13264.0 4382.5 4402.1 4445.5 4456.9 4557.8 80801.6 81149.6 83417.2 85258.1 85360.7 11346.5 11379.2 11388.5 11473.4 11570.0 21067.2 21111.2 21136.5 21144.2 21157.4 8173.4 8373.5 8513.1 8525.7 8704.5 4629.5 4660.5 4682.6 4687.3 4775.6 3322.7 3426.2 3437.5 3444.1 3444.3 637.2 649.2 654.1 655.5 660.7 542.2 658.3 666.9 675.6 681.8 9240.4 9652.9 9666.2 9854.2 9955.2 656.3 668.4 672.4 676.8 699.8 4499.7 4624.1 4636.2 4687.2 4711.3 68109.7 68499.0 92299.5 97327.5 98583.0 92934.5 93851.5 94091.5 95190.0 95446.0 80572.2 80578.0 80697.2 81157.0 83113.0 9098.4 9393.3 9452.4 9708.0 10188.4 44574.8 47644.8 49774.0 49775.3 51286.0 47138.8 59162.4 60720.0 69366.0 70099.6 12477.6 12526.7 12956.4 13509.3 13830.9 13938.0 14144.2 14538.3 14562.9 14710.7 12604.5 12908.2 13140.9 14015.9 14368.6 12476.9 12913.3 13200.9 13317.5 13321.5 13479.5 13506.4 13653.6 13838.5 14384.9 10645.8 10871.5 11048.8 11625.6 11730.8 10600.5 11163.9 11326.7 11447.7 11463.8 06:42:54 INFO - PROCESS | 22196 | -------- Summary: end -------- 06:42:54 INFO - PROCESS | 22196 | 06:42:55 INFO - TEST-INFO | 22196: exit 0 06:42:55 INFO - TEST-OK | dromaeo_css | took 1118581ms 06:42:55 INFO - TEST-START | kraken 06:42:55 INFO - operating with platform_type : linux_ 06:42:55 INFO - Initialising browser for kraken test... 06:42:55 INFO - TEST-INFO | started process 22500 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAwZJZA/profile http://localhost:43558/getInfo.html) 06:42:59 INFO - PROCESS | 22500 | __metrics Screen width/height:1600/1200 06:42:59 INFO - PROCESS | 22500 | colorDepth:24 06:42:59 INFO - PROCESS | 22500 | Browser inner width/height: 1024/697 06:42:59 INFO - PROCESS | 22500 | __metrics 06:43:00 INFO - PROCESS | 22500 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:43:00 INFO - PROCESS | 22500 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:43:01 INFO - PROCESS | 22500 | console.error: PushService: 06:43:01 INFO - PROCESS | 22500 | stateChangeProcessEnqueue: Error transitioning state 06:43:01 INFO - PROCESS | 22500 | UnknownError 06:43:01 INFO - TEST-INFO | 22500: exit 0 06:43:01 INFO - Browser initialized. 06:43:01 INFO - Running cycle 1/1 for kraken test... 06:43:01 INFO - TEST-INFO | started process 22583 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAwZJZA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:43:13 INFO - PROCESS | 22583 | RSS: Main: 173780992 06:43:13 INFO - PROCESS | 22583 | 06:43:16 INFO - PROCESS | 22583 | Cycle 1(1): loaded http://localhost:43558/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43558/tests/kraken/driver.html?testName=audio-beat-detection) 06:43:17 INFO - PROCESS | 22583 | RSS: Main: 232132608 06:43:17 INFO - PROCESS | 22583 | 06:43:19 INFO - PROCESS | 22583 | Cycle 1(1): loaded http://localhost:43558/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43558/tests/kraken/driver.html?testName=audio-dft) 06:43:20 INFO - PROCESS | 22583 | RSS: Main: 217559040 06:43:20 INFO - PROCESS | 22583 | 06:43:23 INFO - PROCESS | 22583 | Cycle 1(1): loaded http://localhost:43558/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43558/tests/kraken/driver.html?testName=audio-fft) 06:43:24 INFO - PROCESS | 22583 | RSS: Main: 300015616 06:43:24 INFO - PROCESS | 22583 | 06:43:26 INFO - PROCESS | 22583 | Cycle 1(1): loaded http://localhost:43558/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43558/tests/kraken/driver.html?testName=audio-oscillator) 06:43:26 INFO - PROCESS | 22583 | RSS: Main: 211136512 06:43:26 INFO - PROCESS | 22583 | 06:43:29 INFO - PROCESS | 22583 | Cycle 1(1): loaded http://localhost:43558/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43558/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:43:29 INFO - PROCESS | 22583 | RSS: Main: 213729280 06:43:29 INFO - PROCESS | 22583 | 06:43:32 INFO - PROCESS | 22583 | Cycle 1(1): loaded http://localhost:43558/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43558/tests/kraken/driver.html?testName=imaging-darkroom) 06:43:33 INFO - PROCESS | 22583 | RSS: Main: 249741312 06:43:33 INFO - PROCESS | 22583 | 06:43:36 INFO - PROCESS | 22583 | Cycle 1(1): loaded http://localhost:43558/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43558/tests/kraken/driver.html?testName=imaging-desaturate) 06:43:37 INFO - PROCESS | 22583 | RSS: Main: 248762368 06:43:37 INFO - PROCESS | 22583 | 06:43:40 INFO - PROCESS | 22583 | Cycle 1(1): loaded http://localhost:43558/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43558/tests/kraken/driver.html?testName=json-parse-financial) 06:43:40 INFO - PROCESS | 22583 | RSS: Main: 248549376 06:43:40 INFO - PROCESS | 22583 | 06:43:42 INFO - PROCESS | 22583 | Cycle 1(1): loaded http://localhost:43558/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43558/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:43:42 INFO - PROCESS | 22583 | RSS: Main: 211337216 06:43:42 INFO - PROCESS | 22583 | 06:43:44 INFO - PROCESS | 22583 | Cycle 1(1): loaded http://localhost:43558/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43558/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:43:45 INFO - PROCESS | 22583 | RSS: Main: 218312704 06:43:45 INFO - PROCESS | 22583 | 06:43:47 INFO - PROCESS | 22583 | Cycle 1(1): loaded http://localhost:43558/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43558/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:43:47 INFO - PROCESS | 22583 | RSS: Main: 227590144 06:43:47 INFO - PROCESS | 22583 | 06:43:50 INFO - PROCESS | 22583 | Cycle 1(1): loaded http://localhost:43558/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43558/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:43:51 INFO - PROCESS | 22583 | RSS: Main: 236486656 06:43:51 INFO - PROCESS | 22583 | 06:43:54 INFO - PROCESS | 22583 | Cycle 1(1): loaded http://localhost:43558/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43558/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:43:54 INFO - PROCESS | 22583 | RSS: Main: 233402368 06:43:54 INFO - PROCESS | 22583 | 06:43:56 INFO - PROCESS | 22583 | Cycle 1(1): loaded http://localhost:43558/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43558/tests/kraken/driver.html?testName=ai-astar) 06:43:56 INFO - PROCESS | 22583 | RSS: Main: 283414528 06:43:56 INFO - PROCESS | 22583 | 06:43:56 INFO - PROCESS | 22583 | __start_tp_report 06:43:56 INFO - PROCESS | 22583 | _x_x_mozilla_page_load 06:43:56 INFO - PROCESS | 22583 | _x_x_mozilla_page_load_details 06:43:56 INFO - PROCESS | 22583 | |i|pagename|runs| 06:43:56 INFO - PROCESS | 22583 | |0;ai-astar;110;112;113;113;122;113;114;113;112;113 06:43:56 INFO - PROCESS | 22583 | |1;audio-beat-detection;152;123;121;162;123;127;123;123;150;120 06:43:56 INFO - PROCESS | 22583 | |2;audio-dft;161;161;160;161;160;163;160;161;161;162 06:43:56 INFO - PROCESS | 22583 | |3;audio-fft;75;75;75;116;76;76;75;76;99;76 06:43:56 INFO - PROCESS | 22583 | |4;audio-oscillator;84;83;114;84;84;83;108;84;83;115 06:43:56 INFO - PROCESS | 22583 | |5;imaging-gaussian-blur;117;117;117;117;118;117;118;118;117;117 06:43:56 INFO - PROCESS | 22583 | |6;imaging-darkroom;145;147;154;145;145;145;145;146;145;146 06:43:56 INFO - PROCESS | 22583 | |7;imaging-desaturate;96;96;95;96;96;96;96;96;96;96 06:43:56 INFO - PROCESS | 22583 | |8;json-parse-financial;51;50;50;51;53;53;53;52;53;54 06:43:56 INFO - PROCESS | 22583 | |9;json-stringify-tinderbox;61;62;60;61;61;62;62;62;61;61 06:43:56 INFO - PROCESS | 22583 | |10;stanford-crypto-aes;89;80;89;83;89;81;81;80;80;90 06:43:56 INFO - PROCESS | 22583 | |11;stanford-crypto-ccm;130;136;129;141;128;138;131;141;165;129 06:43:56 INFO - PROCESS | 22583 | |12;stanford-crypto-pbkdf2;171;165;167;165;169;166;169;169;166;161 06:43:56 INFO - PROCESS | 22583 | |13;stanford-crypto-sha256-iterative;66;66;65;65;64;64;69;65;63;66 06:43:56 INFO - PROCESS | 22583 | __end_tp_report 06:43:56 INFO - PROCESS | 22583 | __start_cc_report 06:43:56 INFO - PROCESS | 22583 | _x_x_mozilla_cycle_collect,1702 06:43:56 INFO - PROCESS | 22583 | __end_cc_report 06:43:56 INFO - PROCESS | 22583 | __startTimestamp1475588636621__endTimestamp 06:43:56 INFO - PROCESS | 22583 | 06:43:56 INFO - PROCESS | 22583 | ------- Summary: start ------- 06:43:56 INFO - PROCESS | 22583 | Number of tests: 14 06:43:56 INFO - PROCESS | 22583 | 06:43:56 INFO - PROCESS | 22583 | [#0] ai-astar Cycles:10 Average:113.50 Median:113.00 stddev:3.17 (2.8%) stddev-sans-first:3.10 06:43:56 INFO - PROCESS | 22583 | Values: 110.0 112.0 113.0 113.0 122.0 113.0 114.0 113.0 112.0 113.0 06:43:56 INFO - PROCESS | 22583 | 06:43:56 INFO - PROCESS | 22583 | [#1] audio-beat-detection Cycles:10 Average:132.40 Median:125.00 stddev:15.76 (12.6%) stddev-sans-first:15.04 06:43:56 INFO - PROCESS | 22583 | Values: 152.0 123.0 121.0 162.0 123.0 127.0 123.0 123.0 150.0 120.0 06:43:56 INFO - PROCESS | 22583 | 06:43:56 INFO - PROCESS | 22583 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.94 (0.6%) stddev-sans-first:1.00 06:43:56 INFO - PROCESS | 22583 | Values: 161.0 161.0 160.0 161.0 160.0 163.0 160.0 161.0 161.0 162.0 06:43:56 INFO - PROCESS | 22583 | 06:43:56 INFO - PROCESS | 22583 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.00 stddev:14.08 (18.5%) stddev-sans-first:14.71 06:43:56 INFO - PROCESS | 22583 | Values: 75.0 75.0 75.0 116.0 76.0 76.0 75.0 76.0 99.0 76.0 06:43:56 INFO - PROCESS | 22583 | 06:43:56 INFO - PROCESS | 22583 | [#4] audio-oscillator Cycles:10 Average:92.20 Median:83.50 stddev:14.01 (16.8%) stddev-sans-first:14.55 06:43:56 INFO - PROCESS | 22583 | Values: 84.0 83.0 114.0 84.0 84.0 83.0 108.0 84.0 83.0 115.0 06:43:56 INFO - PROCESS | 22583 | 06:43:56 INFO - PROCESS | 22583 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 06:43:56 INFO - PROCESS | 22583 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 118.0 118.0 117.0 117.0 06:43:56 INFO - PROCESS | 22583 | 06:43:56 INFO - PROCESS | 22583 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:145.50 stddev:2.79 (1.9%) stddev-sans-first:2.92 06:43:56 INFO - PROCESS | 22583 | Values: 145.0 147.0 154.0 145.0 145.0 145.0 145.0 146.0 145.0 146.0 06:43:56 INFO - PROCESS | 22583 | 06:43:56 INFO - PROCESS | 22583 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 06:43:56 INFO - PROCESS | 22583 | Values: 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 06:43:56 INFO - PROCESS | 22583 | 06:43:56 INFO - PROCESS | 22583 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:53.00 stddev:1.41 (2.7%) stddev-sans-first:1.45 06:43:56 INFO - PROCESS | 22583 | Values: 51.0 50.0 50.0 51.0 53.0 53.0 53.0 52.0 53.0 54.0 06:43:56 INFO - PROCESS | 22583 | 06:43:56 INFO - PROCESS | 22583 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.50 stddev:0.67 (1.1%) stddev-sans-first:0.71 06:43:56 INFO - PROCESS | 22583 | Values: 61.0 62.0 60.0 61.0 61.0 62.0 62.0 62.0 61.0 61.0 06:43:56 INFO - PROCESS | 22583 | 06:43:56 INFO - PROCESS | 22583 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:86.00 stddev:4.44 (5.2%) stddev-sans-first:4.36 06:43:56 INFO - PROCESS | 22583 | Values: 89.0 80.0 89.0 83.0 89.0 81.0 81.0 80.0 80.0 90.0 06:43:56 INFO - PROCESS | 22583 | 06:43:56 INFO - PROCESS | 22583 | [#11] stanford-crypto-ccm Cycles:10 Average:136.80 Median:137.00 stddev:11.11 (8.1%) stddev-sans-first:11.51 06:43:56 INFO - PROCESS | 22583 | Values: 130.0 136.0 129.0 141.0 128.0 138.0 131.0 141.0 165.0 129.0 06:43:56 INFO - PROCESS | 22583 | 06:43:56 INFO - PROCESS | 22583 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.80 Median:168.00 stddev:2.86 (1.7%) stddev-sans-first:2.60 06:43:56 INFO - PROCESS | 22583 | Values: 171.0 165.0 167.0 165.0 169.0 166.0 169.0 169.0 166.0 161.0 06:43:56 INFO - PROCESS | 22583 | 06:43:56 INFO - PROCESS | 22583 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.50 stddev:1.64 (2.5%) stddev-sans-first:1.72 06:43:56 INFO - PROCESS | 22583 | Values: 66.0 66.0 65.0 65.0 64.0 64.0 69.0 65.0 63.0 66.0 06:43:56 INFO - PROCESS | 22583 | -------- Summary: end -------- 06:43:56 INFO - PROCESS | 22583 | 06:43:57 INFO - TEST-INFO | 22583: exit 0 06:43:57 INFO - TEST-OK | kraken | took 62660ms 06:43:57 INFO - SUITE-END | took 1181s 06:43:58 INFO - Completed test suite (00:19:41) 06:43:58 INFO - javascript benchmark 06:43:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2975.8958436454723, 3009.3830764693234, 3011.9548206776903, 3042.54361845723, 3052.587900633414, 5036.6222533309965, 5074.847754567364, 5106.897862042757, 5127.461616530267, 5164.715940623264, 5100.336956195699, 5119.0, 5123.487651234875, 5133.691978481284, 5140.126178549646, 4710.623150147997, 4775.761211939398, 4776.761161941907, 4780.354652121971, 4784.688995215317, 4672.532746725335, 4794.808207671689, 4811.278308253755, 4836.613070954333, 4902.313676085351, 4768.117898188829, 4768.833090841821, 4795.136875362434, 4820.156472617296, 4877.02459508098, 4568.634509239286, 4581.037982023779, 4612.446506419217, 4762.857114286577, 4777.641676874248, 4618.56123668251, 4634.83778067766, 4644.187267228222, 4666.859994200179, 4730.101280756679, 5047.722375269359, 5052.216906379517, 5055.595552355802, 5074.619403544712, 5133.281340612317, 5304.310439642822, 5446.700431476267, 5453.863653408657, 5465.098258787335, 5466.890662186774, 5369.060414427459, 5495.780168793243, 5528.308961379827, 5547.944520554784, 5636.15457681347, 5199.064168449678, 5210.088234559013, 5210.478952104835, 5210.609204309692, 5213.921791173136, 5654.6889921054735, 5655.5475561954945, 5658.91511627326, 5661.603687741818, 5729.942700572941, 5298.735063246822, 5338.893222135535, 5380.166074258496, 5411.783528658888, 5426.701531415731, 5495.120780675073, 5500.834974950758, 5506.03644362243, 5536.695481748462, 5572.3034620672415, 5435.266239057755, 5450.836474905759, 5476.452354764491, 5495.258140151109, 5504.91742623861, 5350.732463376893, 5429.022775900376, 5431.456854314537, 5507.7246137692955, 5564.471375219428, 4184.5187803403, 4204.8528301509305, 4220.915581688349, 4223.092035212444, 4271.060366719316, 3750.9062273442837, 3755.136318646672, 3756.248750249906, 3792.469054332396, 3797.430385442206, 5122.282880396748, 5175.896482070413, 5178.559822415062, 5183.559397451183, 5245.213218017251, 5405.972970135124, 5500.889982200333, 5581.386047534768, 5590.24531688225, 5601.047821870292, 5238.947610523922, 5255.185446255837, 5260.947390526046, 5262.342207224097, 5266.1574148136115, 4778.522147785194, 4810.470848206694, 4814.831480898151, 4818.0, 4856.878578035577, 5521.834344969658, 5610.775568977277, 5616.045272303718, 5632.380438151882, 5703.686297253691, 5442.401335852974, 5447.863803404946, 5451.591130665295, 5452.591055670761, 5458.6724796512335, 5691.402402747652, 5693.516051135534, 5693.857653558529, 5702.942970570407, 5706.4864162225595, 5319.654222475527, 5347.812826551052, 5355.544778693855, 5362.061639213044, 5365.409804921534, 5463.836084917459, 5467.261919640798, 5471.151971444432, 5474.589405794661, 5476.753546090516, 5307.283516725347, 5329.0, 5330.600204984719, 5333.573314134937, 5333.78664853417, 5323.0684630190335, 5325.440828712929, 5331.306930099062, 5352.785888564569, 5396.487333703292, 5376.731163441734, 5382.0, 5388.488093631099, 5389.27244821944, 5451.64564303319, 5215.973920130375, 5245.763940622604, 5350.0, 5392.083345831296, 5418.241446197457, 5230.2677625131755, 5270.130428479411, 5276.023935571931, 5323.653962492581, 5329.413764485826], "value": 5075.710228467121, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.3429556010587, 594.9405059494054, 603.6589327030227, 605.9787907423241, 606.4178388746802, 32820.83589582055, 43985.56014439854, 45302.32046519305, 45515.089698206015, 48453.75773121129, 46717.0, 47097.29354059692, 47168.764156179255, 47202.0, 47292.290615640704, 8968.013518512975, 9123.726288211365, 9124.954375228115, 9125.49809760463, 9128.680496182635, 8250.46371985822, 8444.831103377928, 10760.0, 11006.119510439146, 11006.504707288152, 11167.83248251277, 11278.605248816293, 11282.435878206097, 11285.943570282137, 11287.943560282187, 11059.281146725438, 11117.999380055793, 11124.221304508688, 11129.387883666395, 11137.443127843575, 10856.837147442795, 10934.835977460345, 10938.343699378063, 10945.23383363165, 10948.3978381189, 43508.56491435077, 43604.56395436037, 43805.0, 44004.0, 44006.339904901455, 3435.7594968351978, 3449.6205417404067, 3468.3756923753713, 3469.65303469651, 3497.8600855965733, 31790.682093179003, 31878.681213187803, 32360.838195809105, 32474.0, 32514.674853251403, 4307.633851122659, 4449.599536041772, 4454.665900057508, 4490.169318676056, 4536.7504787236685, 329617.0, 332475.0, 332783.0, 333712.3314383437, 334002.0, 59610.70194648999, 59820.70089649524, 59898.01529770569, 60028.39971600316, 60355.0, 60733.0, 60746.0, 65208.0, 65282.67358663176, 65588.67205664037, 17203.65592688139, 17472.990606080464, 17475.300987960338, 17480.65038699244, 17484.65030699379, 12060.336681482428, 12311.753764924651, 13206.537771177962, 13357.198568085945, 13379.0, 19562.21751129939, 20160.49598760043, 20282.797172028386, 20756.377308680763, 20893.582128357346, 7332.156801967735, 7389.8152546186775, 7519.360854327334, 7546.169921308651, 7701.614919254127, 959.8848138223458, 1029.5727273181697, 1064.892511787732, 1066.2642776484201, 1088.77135801481, 32698.0, 32851.1787205317, 32956.0, 32971.50542741813, 33039.3392132156, 1068.6206396729206, 1076.967690969272, 1125.8363997167985, 1144.8797876223043, 1165.2309475745967, 16779.496615101565, 17376.306672465787, 17427.73858392125, 17542.0, 17610.0, 476586.0, 489971.0, 490976.0, 492711.0, 495104.0, 59992.400075999554, 60214.39785602088, 60216.397836021955, 60494.395056049754, 60528.69735651294, 1216.7079900823915, 1269.2765123879485, 1347.508159521787, 1366.658335416146, 1389.0832050846595, 30160.0, 32775.34449310953, 33876.83061584676, 34640.480392794634, 36923.63076369202, 55355.72322138525, 56505.0, 56575.60546367231, 61636.0, 61702.38297616966, 433600.0, 441276.0, 441908.0, 443464.0, 445654.5759068148, 44841.0, 45897.31154032626, 46008.0, 46725.53274467212, 48577.75711121422, 50242.24636630381, 50320.496795031584, 51029.489705102475, 51065.48934510607, 51262.48737512726, 41780.791096044326, 42958.0, 43203.0, 43256.0, 45185.548144519445, 42036.0, 42207.577924221594, 42968.35547466728, 42999.14001720011, 44394.0, 41491.7925410371, 42325.36511952385, 42682.0, 43035.569644303156, 43231.78384108059, 35846.46230306599, 37759.43360849535, 38214.0, 39100.608993910835, 39158.80420597879, 28336.85831570829, 28825.855870720512, 29016.419671606873, 29146.41707165887, 30075.0], "value": 21287.266399728756, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.965328293812, 377.7185996432658, 388.1790014120136, 393.1213737297141, 417.0803378550297, 13903.44386224551, 14059.196096310716, 15414.922925385357, 17668.558286042855, 17756.46730598081, 18575.164117614706, 19080.522986925298, 19404.90297548514, 19508.0, 19650.803491965074, 5460.099083651193, 5684.54523638108, 5693.060644993571, 5696.943030569703, 5700.6579605223615, 5372.597055220874, 5544.695041772701, 5577.079781835992, 5582.7766889324375, 5603.915941260884, 5506.146547285177, 5549.556035517149, 5555.555555555546, 5561.360443549003, 5564.054110801174, 5313.335833020872, 5461.726913654321, 5481.561475081984, 5491.835244942658, 5495.120780675113, 4900.215965445547, 4904.288878112689, 4909.042736666352, 4912.38595175603, 4912.606991440676, 21484.248051318285, 22014.669779953314, 22271.55456890853, 22457.775422245733, 22600.095996160133, 2135.011908135806, 2241.932742017742, 2403.807695384365, 2486.502699460097, 2632.6445929799424, 10082.344647597884, 10271.435071071088, 10581.84127238092, 10679.626213082582, 10882.455877206108, 1838.4208974173227, 1865.291189348039, 1890.971635425456, 1893.7159426086198, 1904.3430016644375, 80767.0, 84547.0, 84974.0, 85413.57293213556, 88295.55852220762, 10406.323588966692, 10507.527161277761, 10992.395418251914, 11025.967858838883, 11291.49188286529, 15227.238638068053, 15241.390344386322, 15241.771373429407, 15257.465988690343, 15266.16036118002, 8008.599570021475, 8064.395170362129, 8090.514569125871, 8296.958515207507, 8312.625931833081, 7811.101723301779, 7813.609319534001, 8055.113937466874, 8065.919340806634, 8084.151164127799, 4473.865784026484, 4607.746573938399, 4651.697639653412, 4711.340412342275, 4872.78072486739, 1970.3694817658497, 2008.5279959209574, 2023.1806118522022, 2024.3724445421967, 2067.441790716498, 925.1765928323797, 939.5818860606964, 947.9431234125974, 1006.4716024087413, 1015.2487159501916, 17618.0, 19688.507787305145, 19756.802431975495, 19778.208871644973, 19942.1026053825, 960.188640598693, 960.9519524023771, 1012.8176928152856, 1013.6502906497246, 1026.2610920137488, 10573.735656608646, 10992.945035274932, 11050.171237157085, 11051.226414150933, 11101.944490277498, 431232.0, 433218.0, 434821.0, 437165.0, 438919.8864090865, 86687.0, 87325.56337218273, 87839.0, 89304.23164360084, 91605.5419722897, 942.8632848237104, 943.8112377524523, 960.8991055939166, 960.9519524023771, 977.4672803322206, 16750.832491674926, 17045.0, 17454.0, 17571.736423953906, 17699.20353584066, 42796.572034279256, 43157.56842431535, 43274.13451730885, 43275.35086973635, 44538.3319250218, 57999.71000145141, 58092.19078092326, 59448.108278374995, 59908.70045649744, 60160.39839601548, 8093.433459657767, 8328.541930193898, 8331.6667333306, 8429.915700843158, 8457.957710211409, 12228.082893782825, 12256.448459819509, 12280.201786883825, 12461.87538124607, 12610.18033827835, 10679.89320106789, 10882.12942964545, 10906.945465272624, 11248.606298779503, 11753.764924701287, 10725.356478611307, 10767.825318616793, 10867.29362591429, 11141.275817071864, 11296.0, 11061.0, 11542.94228528852, 11587.594434194763, 11700.47347869365, 11819.231749936227, 6788.626625535643, 7327.413806895543, 7367.742129025459, 7649.349805266615, 8761.080086591071, 10889.509972051435, 10940.0, 10991.560337586407, 11392.25950313227, 11698.532058717556], "value": 8970.922019966636, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1347.8180445639837, 1456.9927150364247, 1494.8654621084102, 1586.7619857021446, 1756.947291581253, 7305.342519173273, 7820.7653770386905, 8590.26982706469, 8841.778955526099, 8863.379563430562, 8636.654533818655, 8717.21545060946, 8735.126487351261, 8737.868931966026, 8744.125587441253, 2313.6066868632374, 2322.686437330964, 2350.3654013416367, 2351.6002279612508, 2354.564405584972, 2254.402583315423, 2305.0203663443053, 2336.5816380046654, 2345.589521833681, 2346.6975828415225, 2311.2719493359623, 2311.514581937795, 2339.099446713011, 2350.0247397330086, 2357.045396614374, 2251.268337790225, 2253.3915842722454, 2254.7745225477483, 2261.344210179046, 2261.9934129312464, 2233.932982010542, 2237.1498830444325, 2237.876916769577, 2240.19353032908, 2243.1588154442084, 8496.957515212385, 8527.872081918777, 8584.31325493959, 8619.741407757714, 8620.65517379304, 5099.821506247301, 5276.0, 5389.946100538984, 5408.91886621701, 5424.83725488232, 3289.555909952174, 3417.5898892133105, 3468.6011108722314, 3482.2861313430685, 3496.4405695088917, 941.7928055827707, 971.7376308396694, 985.6944347252303, 992.4640694025218, 994.2443742755557, 11752.588659396966, 11834.112441566916, 11857.703557411047, 11901.821472678002, 11975.922167004925, 4398.0, 4531.796069176895, 4601.102784956901, 4678.742669153161, 4682.578567928835, 9330.066993300616, 9338.57976391064, 9339.533023348806, 9341.626334946663, 9343.672971445967, 5231.215317702375, 5246.422893481714, 5248.921266181011, 5249.2126181073145, 5251.737413129328, 4195.748255104703, 4316.0, 4718.268668356342, 4856.125897338513, 4923.926141107886, 3648.835802388899, 3680.5215322008503, 3758.962410375916, 3798.240351929625, 3861.0733423978604, 1141.531971891537, 1142.7714457108611, 1144.5135817277624, 1156.2831044752306, 1165.81929800881, 785.9724909628136, 839.2782207301716, 947.5499137909438, 950.4297421547017, 999.8250306196387, 5333.466653334713, 5517.310336207974, 5565.833025009175, 5675.233843431084, 5979.910301345483, 481.92048312028123, 490.45069522135435, 495.10633306880703, 501.98494045178705, 659.1661548141604, 3764.3036038333, 3911.8435262589746, 3916.138449541096, 3932.6853851692367, 4022.1955608878343, 10155.0, 10489.632862849763, 10524.31591946521, 10524.421156836448, 10530.262881598215, 10454.163666906628, 10651.094656954245, 10765.0, 10771.461426928623, 10771.676849694522, 7777.455578109478, 7818.726344578026, 7861.174576669482, 7942.324902383362, 7950.840983180419, 5516.641418307797, 5531.778728850962, 5545.694986775766, 5744.913826292525, 5760.130029088202, 9323.580438880132, 9411.341206115507, 9434.81130377375, 9495.43027418357, 9552.85670714926, 9966.252531060345, 10056.396616203052, 10069.798604028025, 10076.94961525217, 10077.496125193858, 7049.7885063448175, 7129.108861392326, 7131.25121862197, 7133.714651414093, 7137.928620713934, 8149.144339844231, 8165.305948994402, 8219.465734727224, 8233.629486672995, 8271.131531189138, 7033.683484243324, 7048.929510705032, 7094.787156385317, 7512.962435187789, 7539.773806785805, 7364.3372096511575, 7413.332800048021, 7418.48070635072, 7559.622018898923, 7600.0, 6701.195856497252, 6771.6614169292325, 6809.38715515606, 6867.553609015398, 6916.997035429935, 4753.500882407436, 4810.062037902575, 4828.420589529139, 4884.12085824555, 4952.975235123801, 4591.908161836812, 4807.975960120177, 4818.229083346788, 4948.505149485167, 4985.850424487271], "value": 4395.62162909453, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.9779515433919, 323.7798297157933, 337.71631829263424, 338.20015662957104, 348.01338206185466, 4934.6299027572895, 5099.286099946006, 5166.416791604198, 5168.457311982244, 5219.086659834528, 4978.751062446872, 5097.668651537648, 5103.974480127604, 5113.539781419671, 5127.231674542674, 4067.0849058961644, 4071.4503542021744, 4076.2051399977017, 4093.6520395766397, 4101.52832424272, 3937.2912875682364, 4064.796760161995, 4089.3048181809013, 4102.261592913274, 4130.297849365615, 4038.7374820636564, 4066.32905570582, 4067.5932406759384, 4085.9795701021453, 4095.2219078375015, 4030.355143177107, 4040.0, 4061.0, 4070.206309769596, 4076.9184616307803, 3639.581448133472, 3652.6164752701116, 3660.158163622382, 3661.9450708239397, 3668.7615305005356, 4824.807007719687, 4999.975000124976, 5019.4227663818765, 5070.822521211777, 5084.949150508522, 4580.404547408815, 4580.610648094916, 4580.702254353457, 4580.900583859883, 4611.677182597219, 5383.327084114486, 5392.703401312926, 5396.703181325026, 5444.727763611843, 5471.50756431923, 3832.789196594214, 3932.5477570079233, 3980.1840622672285, 4033.2941735196223, 4061.370487574401, 5502.889942201174, 5547.944520554784, 5560.36055853578, 5563.193336966157, 5582.609217354787, 4115.36211887158, 4135.110951145518, 4155.4182414462, 4158.0, 4165.812538435777, 4029.959700403017, 4159.1265834175165, 4205.705600607989, 4207.768572728468, 4214.431051808028, 4694.694844835075, 4701.670883038223, 4710.199266124767, 4732.455767586703, 4735.479097299294, 5326.440723723953, 5401.810936617199, 5423.29497165366, 5427.592930530147, 5436.238926550207, 1354.7696891528267, 1360.7482615716124, 1377.8139951106673, 1389.451166789133, 1422.267532220907, 921.8340698674303, 939.4504215034145, 945.9668911588061, 952.4333021851987, 969.9951500242595, 4656.394668693116, 4674.906501869944, 4675.95324046762, 4684.6486513510945, 4703.670743047954, 4844.927326090112, 4860.3195552622665, 4863.927041094386, 4864.708117512961, 4875.7074575524875, 4622.907541849144, 4630.398048253773, 4636.744979026186, 4667.649926255544, 4668.883277918079, 2739.8082134250412, 2934.7967333393635, 2947.852607369623, 2960.955585666217, 2962.244627619943, 5812.6630874898165, 5813.273340832396, 5822.417758224228, 5824.155497452845, 5827.533797296206, 5514.310711161105, 5672.716364181774, 5672.744726487318, 5699.430056994351, 5737.356778445717, 5782.45066718661, 5793.102069179284, 5794.82615521535, 5805.593608447452, 5823.417658234142, 5558.333000039859, 5558.471945165203, 5567.498925096761, 5568.220449137043, 5588.30146231721, 5283.973580132075, 5462.016836969384, 5478.890422191614, 5498.890022199614, 5510.724463776875, 5750.741216645178, 5786.3056433228285, 5808.477237048517, 5812.21535092757, 5891.3224979127945, 3796.6013568574904, 3982.143839074613, 3989.740666856645, 3997.620226078518, 4009.7594144351433, 5265.368155821326, 5507.614466987273, 5546.251256080377, 5548.528375088163, 5556.694381809039, 5251.186066159751, 5296.947030529799, 5370.9731451342495, 5404.216388623706, 5452.209429632601, 5390.4879036491475, 5417.106177480671, 5455.563554915677, 5461.426550212171, 5473.425290344616, 5311.707856067799, 5406.324209473816, 5433.9184912225555, 5434.559841642047, 5446.727663616724, 5463.890722185613, 5464.699441530754, 5464.9453505464435, 5480.492864462305, 5487.972560137174, 5305.814296499604, 5318.175682769177, 5348.465153484621, 5351.117065684119, 5370.865728356823], "value": 4123.559726781502, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [754.1252147508891, 754.826389930316, 758.2038859197844, 786.4612740272913, 835.6907944060697, 15838.84161158388, 16115.677686446294, 16149.354025838982, 16438.424655137074, 16483.34066637333, 16478.7528187077, 16553.917230413863, 16594.83405165948, 16607.66784664306, 16608.66782664346, 669.8928171492562, 813.7396033269356, 825.628467189764, 826.1738261738262, 827.3050637464529, 683.0505597219868, 801.5511313664366, 810.2707563193114, 824.2499325613662, 824.4558591329694, 846.1073567386405, 846.8137009857821, 851.9446235994641, 852.6291063387415, 853.4367317570404, 693.1508901595555, 846.1622993236713, 846.3736834742308, 847.0851480401152, 849.5794581682076, 522.5088416888113, 614.0727501472763, 620.695859029077, 631.2803404119308, 632.4213344789512, 14465.421383144767, 14474.42102315906, 14501.927490362586, 14515.201663908481, 14523.636909077251, 12411.813822792665, 12655.683607909783, 12773.680657983532, 12785.479007652586, 12877.806832897513, 12937.805932911015, 12994.425863991082, 13030.15304005246, 13241.801372979413, 13264.020793761929, 4382.452193475816, 4402.119576084764, 4445.466544014706, 4456.8885777855485, 4557.772111394417, 80801.59599202026, 81149.59425202895, 83417.16582834155, 85258.14741852564, 85360.71958920683, 11346.482590397003, 11379.203455758183, 11388.544458221744, 11473.426328683532, 11569.967064326876, 21067.157313707587, 21111.155553777982, 21136.471588210417, 21144.154233830475, 21157.365279041653, 8173.386995975326, 8373.455725377831, 8513.14868513156, 8525.658973640984, 8704.518192722835, 4629.467611224685, 4660.510646382081, 4682.601978831837, 4687.343771871872, 4775.617950563947, 3322.700956913841, 3426.1777173478185, 3437.5187473753695, 3444.121748954001, 3444.2594842109065, 637.2384999925138, 649.1560970738021, 654.0679531667355, 655.4919937048825, 660.6993817812884, 542.1840130603416, 658.3285049249835, 666.8632930249287, 675.5912672832866, 681.7647911470535, 9240.3526578701, 9652.855207171899, 9666.178374838217, 9854.162396196403, 9955.153811925922, 656.3338211715113, 668.3758466925418, 672.3847679373318, 676.8477092654114, 699.78656509765, 4499.6785943861205, 4624.098300831373, 4636.211843986531, 4687.156311863897, 4711.293306004127, 68109.65945170242, 68499.0, 92299.53850230706, 97327.51336243273, 98583.0, 92934.53532732428, 93851.53074234721, 94091.52954235185, 95190.0, 95446.0, 80572.19427805647, 80578.0, 80697.19302806897, 81157.0, 83113.0, 9098.408603440756, 9393.29550283745, 9452.43285402878, 9707.951460242653, 10188.439635820101, 44574.777126115456, 47644.7617761909, 49774.0, 49775.25337120018, 51286.0, 47138.76430617825, 59162.40837591569, 60720.0, 69366.0, 70099.64950175217, 12477.625671229878, 12526.749465010831, 12956.352182390654, 13509.256990865597, 13830.930845345709, 13938.0, 14144.22206778637, 14538.273086345853, 14562.854371456573, 14710.749586284857, 12604.495820167458, 12908.16096953695, 13140.868591313965, 14015.929920350332, 14368.568942931728, 12476.937615311865, 12913.289769062792, 13200.933995329962, 13317.533886313933, 13321.533746318832, 13479.46082156742, 13506.392212350664, 13653.590392288248, 13838.515651952133, 14384.856151438351, 10645.840312395476, 10871.510782014986, 11048.779024419628, 11625.593104241649, 11730.824037639613, 10600.46997650099, 11163.944180279046, 11326.716832079264, 11447.713807154554, 11463.770724585629], "value": 7419.411959023242, "unit": "score"}], "name": "dromaeo_css", "value": 7120.784223301888, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 113.0, 113.0, 122.0, 113.0, 114.0, 113.0, 112.0, 113.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 123.0, 121.0, 162.0, 123.0, 127.0, 123.0, 123.0, 150.0, 120.0], "value": 132.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 161.0, 160.0, 163.0, 160.0, 161.0, 161.0, 162.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 116.0, 76.0, 76.0, 75.0, 76.0, 99.0, 76.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 114.0, 84.0, 84.0, 83.0, 108.0, 84.0, 83.0, 115.0], "value": 92.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 154.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 50.0, 51.0, 53.0, 53.0, 53.0, 52.0, 53.0, 54.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 60.0, 61.0, 61.0, 62.0, 62.0, 62.0, 61.0, 61.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 80.0, 89.0, 83.0, 89.0, 81.0, 81.0, 80.0, 80.0, 90.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 136.0, 129.0, 141.0, 128.0, 138.0, 131.0, 141.0, 165.0, 129.0], "value": 136.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 165.0, 167.0, 165.0, 169.0, 166.0, 169.0, 169.0, 166.0, 161.0], "value": 166.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 65.0, 64.0, 64.0, 69.0, 65.0, 63.0, 66.0], "value": 65.3, "unit": "score"}], "name": "kraken", "value": 1506.8999999999999, "alertThreshold": 2.0}]} 06:43:58 INFO - Return code: 0 06:43:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:43:58 INFO - # TBPL SUCCESS # 06:43:58 INFO - Running post-action listener: _resource_record_post_action 06:43:58 INFO - [mozharness: 2016-10-04 13:43:58.439045Z] Finished run-tests step (success) 06:43:58 INFO - Running post-run listener: _resource_record_post_run 06:43:58 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392548352; Read time: 4; Write time: 359560 06:43:58 INFO - TinderboxPrint: CPU usage
13.1% 06:43:58 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 06:43:58 INFO - TinderboxPrint: I/O write bytes / time
392,548,352 / 359,560 06:43:58 INFO - TinderboxPrint: CPU idle
8,315.5 (86.9%) 06:43:58 INFO - TinderboxPrint: CPU user
1,200.1 (12.5%) 06:43:58 INFO - TinderboxPrint: Swap in / out
0 / 0 06:43:58 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103739392; Read time: 0; Write time: 113820 06:43:58 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 288808960; Read time: 0; Write time: 245740 06:43:59 INFO - Running post-run listener: _upload_blobber_files 06:43:59 INFO - Blob upload gear active. 06:43:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:43:59 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:43:59 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:43:59 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:43:59 INFO - (blobuploader) - INFO - Open directory for files ... 06:43:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:43:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:43:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:44:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:44:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:44:00 INFO - (blobuploader) - INFO - Done attempting. 06:44:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:44:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:44:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:44:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:44:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:44:03 INFO - (blobuploader) - INFO - Done attempting. 06:44:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:44:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:44:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:44:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:44:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:44:04 INFO - (blobuploader) - INFO - Done attempting. 06:44:04 INFO - (blobuploader) - INFO - Iteration through files over. 06:44:04 INFO - Return code: 0 06:44:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:44:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:44:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b75a91ac4a5208313a3fa60c43bd2e23bdd900c9eddbcf64f98836aab4ed0945f14c734917419379c103a2287458f613bda5b64068e817a88234ab3ab43a7a7d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6d89cb5398ed4c9f2871492edbc67966e0a9dda8e217743feba0274811a83f665255fefdff4721761e789fb414e4a5b1e571375bd21776ba76c5a25806405e67", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/91258a0a804421f4729fa0636a79f0c85f26e4ac8120aed80a3b481cd749ce55d5d481bdeab5e49ee4a25fbcc44b5489acba72645cf86ffb390eb26c1d35c44c"} 06:44:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:44:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:44:04 INFO - Contents: 06:44:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b75a91ac4a5208313a3fa60c43bd2e23bdd900c9eddbcf64f98836aab4ed0945f14c734917419379c103a2287458f613bda5b64068e817a88234ab3ab43a7a7d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6d89cb5398ed4c9f2871492edbc67966e0a9dda8e217743feba0274811a83f665255fefdff4721761e789fb414e4a5b1e571375bd21776ba76c5a25806405e67", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/91258a0a804421f4729fa0636a79f0c85f26e4ac8120aed80a3b481cd749ce55d5d481bdeab5e49ee4a25fbcc44b5489acba72645cf86ffb390eb26c1d35c44c"} 06:44:04 INFO - Running post-run listener: copy_logs_to_upload_dir 06:44:04 INFO - Copying logs to upload dir... 06:44:04 INFO - mkdir: /builds/slave/test/build/upload/logs 06:44:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.945548 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-10-04 06:44:04.349947) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 06:44:04.353160) ========= 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=cbe409c6de289db6ac707de3000001d4-1475583495.835933-1480351109 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/sha512/b75a91ac4a5208313a3fa60c43bd2e23bdd900c9eddbcf64f98836aab4ed0945f14c734917419379c103a2287458f613bda5b64068e817a88234ab3ab43a7a7d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6d89cb5398ed4c9f2871492edbc67966e0a9dda8e217743feba0274811a83f665255fefdff4721761e789fb414e4a5b1e571375bd21776ba76c5a25806405e67", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/91258a0a804421f4729fa0636a79f0c85f26e4ac8120aed80a3b481cd749ce55d5d481bdeab5e49ee4a25fbcc44b5489acba72645cf86ffb390eb26c1d35c44c"} build_url:https://queue.taskcluster.net/v1/task/bMH63fvVSq2JtoPw78lB2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011275 build_url: 'https://queue.taskcluster.net/v1/task/bMH63fvVSq2JtoPw78lB2A/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/sha512/b75a91ac4a5208313a3fa60c43bd2e23bdd900c9eddbcf64f98836aab4ed0945f14c734917419379c103a2287458f613bda5b64068e817a88234ab3ab43a7a7d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6d89cb5398ed4c9f2871492edbc67966e0a9dda8e217743feba0274811a83f665255fefdff4721761e789fb414e4a5b1e571375bd21776ba76c5a25806405e67", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/91258a0a804421f4729fa0636a79f0c85f26e4ac8120aed80a3b481cd749ce55d5d481bdeab5e49ee4a25fbcc44b5489acba72645cf86ffb390eb26c1d35c44c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 06:44:04.382142) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 06:44:04.382563) ========= 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=cbe409c6de289db6ac707de3000001d4-1475583495.835933-1480351109 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004555 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 06:44:04.467207) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 06:44:04.467928) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 06:44:04.468518) ========= ========= Total master_lag: 0.19 =========