builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-056 starttime: 1467361920.71 results: success (0) buildid: 20160701000923 builduid: 9aed0462713e41458c0c0924940ddbff revision: cd5a30817ea4389a01482ef9df5fb0017d26d36c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 01:32:00.706934) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 01:32:00.707366) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 01:32:00.707670) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 01:32:00.727125) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 01:32:00.727439) ========= 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=52faae308a556c440401f8e5000001e8-1467361440.663428-638311842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-01 01:32:01-- 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% 19.9M=0.001s 2016-07-01 01:32:01 (19.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081779 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 01:32:00.825175) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 01:32:00.825511) ========= 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=52faae308a556c440401f8e5000001e8-1467361440.663428-638311842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022846 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 01:32:00.876358) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 01:32:00.876755) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev cd5a30817ea4389a01482ef9df5fb0017d26d36c --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 cd5a30817ea4389a01482ef9df5fb0017d26d36c --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=52faae308a556c440401f8e5000001e8-1467361440.663428-638311842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-01 01:32:02,080 truncating revision to first 12 chars 2016-07-01 01:32:02,080 Setting DEBUG logging. 2016-07-01 01:32:02,080 attempt 1/10 2016-07-01 01:32:02,080 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/cd5a30817ea4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-01 01:32:02,400 unpacking tar archive at: autoland-cd5a30817ea4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.657622 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 01:32:01.551756) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 01:32:01.552083) ========= script_repo_revision: cd5a30817ea4389a01482ef9df5fb0017d26d36c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 01:32:01.552478) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 01:32:01.552798) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 01:32:01.578681) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-01 01:32:01.579095) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1467361440.663428-638311842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:32:02 INFO - MultiFileLogger online at 20160701 01:32:02 in /builds/slave/test 01:32:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 01:32:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:32:02 INFO - {'append_to_log': False, 01:32:02 INFO - 'base_work_dir': '/builds/slave/test', 01:32:02 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 01:32:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:32:02 INFO - 'branch': 'Autoland-Non-PGO', 01:32:02 INFO - 'buildbot_json_path': 'buildprops.json', 01:32:02 INFO - 'config_files': ('talos/linux_config.py',), 01:32:02 INFO - 'default_actions': ('clobber', 01:32:02 INFO - 'read-buildbot-config', 01:32:02 INFO - 'download-and-extract', 01:32:02 INFO - 'populate-webroot', 01:32:02 INFO - 'create-virtualenv', 01:32:02 INFO - 'install', 01:32:02 INFO - 'run-tests'), 01:32:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:32:02 INFO - 'download_minidump_stackwalk': True, 01:32:02 INFO - 'download_symbols': 'ondemand', 01:32:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:32:02 INFO - 'tooltool.py': '/tools/tooltool.py', 01:32:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:32:02 INFO - '/tools/misc-python/virtualenv.py')}, 01:32:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:32:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:32:02 INFO - 'installer_path': 'installer.exe', 01:32:02 INFO - 'log_level': 'info', 01:32:02 INFO - 'log_name': 'talos', 01:32:02 INFO - 'log_to_console': True, 01:32:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:32:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:32:02 INFO - 'opt_config_files': (), 01:32:02 INFO - 'pip_index': False, 01:32:02 INFO - 'sps_profile': False, 01:32:02 INFO - 'sps_profile_interval': 0, 01:32:02 INFO - 'suite': 'dromaeojs-e10s', 01:32:02 INFO - 'system_bits': '32', 01:32:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:32:02 INFO - 'title': 'talos-linux64-ix-056', 01:32:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:32:02 INFO - 'use_talos_json': True, 01:32:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:32:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:32:02 INFO - 'work_dir': 'build'} 01:32:02 INFO - ##### 01:32:02 INFO - ##### Running clobber step. 01:32:02 INFO - ##### 01:32:02 INFO - Running pre-action listener: _resource_record_pre_action 01:32:02 INFO - Running main action method: clobber 01:32:02 INFO - rmtree: /builds/slave/test/build 01:32:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:32:03 INFO - Running post-action listener: _resource_record_post_action 01:32:03 INFO - ##### 01:32:03 INFO - ##### Finished clobber step (success) 01:32:03 INFO - ##### 01:32:03 INFO - ##### 01:32:03 INFO - ##### Running read-buildbot-config step. 01:32:03 INFO - ##### 01:32:03 INFO - Running pre-action listener: _resource_record_pre_action 01:32:03 INFO - Running main action method: read_buildbot_config 01:32:03 INFO - Using buildbot properties: 01:32:03 INFO - { 01:32:03 INFO - "project": "", 01:32:03 INFO - "product": "firefox", 01:32:03 INFO - "script_repo_revision": "production", 01:32:03 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 01:32:03 INFO - "repository": "", 01:32:03 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 01:32:03 INFO - "buildid": "20160701000923", 01:32:03 INFO - "pgo_build": "False", 01:32:03 INFO - "basedir": "/builds/slave/test", 01:32:03 INFO - "buildnumber": 25, 01:32:03 INFO - "slavename": "talos-linux64-ix-056", 01:32:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:32:03 INFO - "platform": "ubuntu64_hw", 01:32:03 INFO - "scheduler": "tests-autoland-linux64-talos", 01:32:03 INFO - "branch": "autoland", 01:32:03 INFO - "repo_path": "integration/autoland", 01:32:03 INFO - "revision": "cd5a30817ea4389a01482ef9df5fb0017d26d36c", 01:32:03 INFO - "stage_platform": "linux64", 01:32:03 INFO - "builduid": "9aed0462713e41458c0c0924940ddbff", 01:32:03 INFO - "slavebuilddir": "test" 01:32:03 INFO - } 01:32:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 01:32:03 INFO - Running post-action listener: _resource_record_post_action 01:32:03 INFO - ##### 01:32:03 INFO - ##### Finished read-buildbot-config step (success) 01:32:03 INFO - ##### 01:32:03 INFO - ##### 01:32:03 INFO - ##### Running download-and-extract step. 01:32:03 INFO - ##### 01:32:03 INFO - Running pre-action listener: _resource_record_pre_action 01:32:03 INFO - Running main action method: download_and_extract 01:32:03 INFO - mkdir: /builds/slave/test/build/tests 01:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:03 INFO - https://queue.taskcluster.net/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:32:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:32:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:32:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:32:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:32:07 INFO - Downloaded 1361 bytes. 01:32:07 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:32:07 INFO - Using the following test package requirements: 01:32:07 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:32:07 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:32:07 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:32:07 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:07 INFO - u'jsshell-linux-x86_64.zip'], 01:32:07 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:32:07 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:32:07 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:32:07 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:32:07 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:32:07 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:32:07 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:32:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:07 INFO - https://queue.taskcluster.net/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:32:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:32:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:32:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:32:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:32:08 INFO - Downloaded 22701821 bytes. 01:32:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:32:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:32:09 INFO - Return code: 0 01:32:09 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:32:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:09 INFO - https://queue.taskcluster.net/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:32:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:32:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:32:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:32:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:32:13 INFO - Downloaded 22701821 bytes. 01:32:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:32:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:32:15 INFO - Return code: 0 01:32:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:15 INFO - https://queue.taskcluster.net/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:32:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:32:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:32:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:32:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:32:16 INFO - Downloaded 14405242 bytes. 01:32:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:32:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 01:32:16 INFO - Return code: 0 01:32:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:16 INFO - https://queue.taskcluster.net/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:32:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:32:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:32:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:32:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:32:17 INFO - Downloaded 56454272 bytes. 01:32:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:32:17 INFO - mkdir: /builds/slave/test/properties 01:32:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:32:17 INFO - Writing to file /builds/slave/test/properties/build_url 01:32:17 INFO - Contents: 01:32:17 INFO - build_url:https://queue.taskcluster.net/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:32:18 INFO - Running post-action listener: _resource_record_post_action 01:32:18 INFO - Running post-action listener: set_extra_try_arguments 01:32:18 INFO - ##### 01:32:18 INFO - ##### Finished download-and-extract step (success) 01:32:18 INFO - ##### 01:32:18 INFO - ##### 01:32:18 INFO - ##### Running populate-webroot step. 01:32:18 INFO - ##### 01:32:18 INFO - Running pre-action listener: _resource_record_pre_action 01:32:18 INFO - Running main action method: populate_webroot 01:32:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:32:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:32:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:32:18 INFO - '--tppagecycles', 01:32:18 INFO - '7'], 01:32:18 INFO - 'tests': ['tsvgm']}}, 01:32:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:32:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:32:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:32:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:32:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:32:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:32:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:32:18 INFO - 'talos_options': ['--disable-e10s'], 01:32:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:32:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:32:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:32:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:32:18 INFO - 'talos_options': ['--disable-e10s'], 01:32:18 INFO - 'tests': ['damp', 'tps']}, 01:32:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:32:18 INFO - 'tests': ['damp', 'tps']}, 01:32:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:32:18 INFO - 'tests': ['dromaeo_dom']}, 01:32:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:32:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:32:18 INFO - 'tests': ['basic_compositor_video']}, 01:32:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:32:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:32:18 INFO - 'tests': ['a11yr', 01:32:18 INFO - 'ts_paint', 01:32:18 INFO - 'tpaint', 01:32:18 INFO - 'sessionrestore', 01:32:18 INFO - 'sessionrestore_no_auto_restore', 01:32:18 INFO - 'tabpaint']}, 01:32:18 INFO - 'other-e10s': {'tests': ['a11yr', 01:32:18 INFO - 'ts_paint', 01:32:18 INFO - 'tpaint', 01:32:18 INFO - 'sessionrestore', 01:32:18 INFO - 'sessionrestore_no_auto_restore', 01:32:18 INFO - 'tabpaint']}, 01:32:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:32:18 INFO - 'ts_paint', 01:32:18 INFO - 'tpaint', 01:32:18 INFO - 'sessionrestore', 01:32:18 INFO - 'sessionrestore_no_auto_restore', 01:32:18 INFO - 'tabpaint']}, 01:32:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:32:18 INFO - 'ts_paint', 01:32:18 INFO - 'tpaint', 01:32:18 INFO - 'sessionrestore', 01:32:18 INFO - 'sessionrestore_no_auto_restore', 01:32:18 INFO - 'tabpaint']}, 01:32:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:32:18 INFO - 'tests': ['a11yr', 01:32:18 INFO - 'ts_paint', 01:32:18 INFO - 'tpaint', 01:32:18 INFO - 'sessionrestore', 01:32:18 INFO - 'sessionrestore_no_auto_restore', 01:32:18 INFO - 'tabpaint']}, 01:32:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:32:18 INFO - 'tests': ['a11yr', 01:32:18 INFO - 'ts_paint', 01:32:18 INFO - 'tpaint', 01:32:18 INFO - 'sessionrestore', 01:32:18 INFO - 'sessionrestore_no_auto_restore', 01:32:18 INFO - 'tabpaint']}, 01:32:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:32:18 INFO - 'tests': ['tsvgx', 01:32:18 INFO - 'tsvgr_opacity', 01:32:18 INFO - 'tart', 01:32:18 INFO - 'tscrollx', 01:32:18 INFO - 'cart']}, 01:32:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:32:18 INFO - 'tsvgr_opacity', 01:32:18 INFO - 'tart', 01:32:18 INFO - 'tscrollx', 01:32:18 INFO - 'cart']}, 01:32:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:32:18 INFO - 'talos_options': ['--disable-e10s'], 01:32:18 INFO - 'tests': ['tp5o']}, 01:32:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:32:18 INFO - 'tests': ['tp5o']}, 01:32:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:32:18 INFO - 'talos_options': ['--disable-e10s', 01:32:18 INFO - '--xperf_path', 01:32:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:32:18 INFO - 'tests': ['tp5n']}, 01:32:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:32:18 INFO - 'talos_options': ['--xperf_path', 01:32:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:32:18 INFO - 'tests': ['tp5n']}}, 01:32:18 INFO - 'talos.zip': {'path': '', 01:32:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:32:18 INFO - Running post-action listener: _resource_record_post_action 01:32:18 INFO - ##### 01:32:18 INFO - ##### Finished populate-webroot step (success) 01:32:18 INFO - ##### 01:32:18 INFO - ##### 01:32:18 INFO - ##### Running create-virtualenv step. 01:32:18 INFO - ##### 01:32:18 INFO - Running pre-action listener: _resource_record_pre_action 01:32:18 INFO - Running main action method: create_virtualenv 01:32:18 INFO - Creating virtualenv /builds/slave/test/build/venv 01:32:18 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 01:32:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:32:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:32:18 INFO - Using real prefix '/usr' 01:32:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:32:19 INFO - Installing distribute.............................................................................................................................................................................................done. 01:32:21 INFO - Installing pip.................done. 01:32:21 INFO - Return code: 0 01:32:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:32:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf89030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1247570>, '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 0x1248470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1248900>, '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': '52faae308a556c440401f8e5000001e8-1467361440.663428-638311842', '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 01:32:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:32:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:32:21 INFO - Using env: {'DISPLAY': ':0', 01:32:21 INFO - 'HOME': '/home/cltbld', 01:32:21 INFO - 'LANG': 'en_US.UTF-8', 01:32:21 INFO - 'LANGUAGE': 'en_US:en', 01:32:21 INFO - 'LOGNAME': 'cltbld', 01:32:21 INFO - 'MAIL': '/var/mail/cltbld', 01:32:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:21 INFO - 'MOZ_NO_REMOTE': '1', 01:32:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:21 INFO - 'NO_EM_RESTART': '1', 01:32:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:21 INFO - 'PWD': '/builds/slave/test', 01:32:21 INFO - 'SHELL': '/bin/bash', 01:32:21 INFO - 'SHLVL': '1', 01:32:21 INFO - 'TERM': 'linux', 01:32:21 INFO - 'TMOUT': '86400', 01:32:21 INFO - 'USER': 'cltbld', 01:32:21 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467361440.663428-638311842', 01:32:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:21 INFO - '_': '/tools/buildbot/bin/python'} 01:32:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:21 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 01:32:21 INFO - Cleaning up... 01:32:21 INFO - Return code: 0 01:32:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:32:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xf89030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1247570>, '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 0x1248470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1248900>, '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': '52faae308a556c440401f8e5000001e8-1467361440.663428-638311842', '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 01:32:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:32:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:32:21 INFO - Using env: {'DISPLAY': ':0', 01:32:21 INFO - 'HOME': '/home/cltbld', 01:32:21 INFO - 'LANG': 'en_US.UTF-8', 01:32:21 INFO - 'LANGUAGE': 'en_US:en', 01:32:21 INFO - 'LOGNAME': 'cltbld', 01:32:21 INFO - 'MAIL': '/var/mail/cltbld', 01:32:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:21 INFO - 'MOZ_NO_REMOTE': '1', 01:32:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:21 INFO - 'NO_EM_RESTART': '1', 01:32:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:21 INFO - 'PWD': '/builds/slave/test', 01:32:21 INFO - 'SHELL': '/bin/bash', 01:32:21 INFO - 'SHLVL': '1', 01:32:21 INFO - 'TERM': 'linux', 01:32:21 INFO - 'TMOUT': '86400', 01:32:21 INFO - 'USER': 'cltbld', 01:32:21 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467361440.663428-638311842', 01:32:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:21 INFO - '_': '/tools/buildbot/bin/python'} 01:32:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:21 INFO - Downloading/unpacking psutil>=3.1.1 01:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:32:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:32:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:32:23 INFO - Installing collected packages: psutil 01:32:23 INFO - Running setup.py install for psutil 01:32:23 INFO - building 'psutil._psutil_linux' extension 01:32:23 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 01:32:23 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 01:32:23 INFO - building 'psutil._psutil_posix' extension 01:32:23 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 01:32:24 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 01:32:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:32:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:32:24 INFO - Successfully installed psutil 01:32:24 INFO - Cleaning up... 01:32:24 INFO - Return code: 0 01:32:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:32:24 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:24 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:24 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 0xf89030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1247570>, '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 0x1248470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1248900>, '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': '52faae308a556c440401f8e5000001e8-1467361440.663428-638311842', '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 01:32:24 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 01:32:24 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 01:32:24 INFO - Using env: {'DISPLAY': ':0', 01:32:24 INFO - 'HOME': '/home/cltbld', 01:32:24 INFO - 'LANG': 'en_US.UTF-8', 01:32:24 INFO - 'LANGUAGE': 'en_US:en', 01:32:24 INFO - 'LOGNAME': 'cltbld', 01:32:24 INFO - 'MAIL': '/var/mail/cltbld', 01:32:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:24 INFO - 'MOZ_NO_REMOTE': '1', 01:32:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:24 INFO - 'NO_EM_RESTART': '1', 01:32:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:24 INFO - 'PWD': '/builds/slave/test', 01:32:24 INFO - 'SHELL': '/bin/bash', 01:32:24 INFO - 'SHLVL': '1', 01:32:24 INFO - 'TERM': 'linux', 01:32:24 INFO - 'TMOUT': '86400', 01:32:24 INFO - 'USER': 'cltbld', 01:32:24 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467361440.663428-638311842', 01:32:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:24 INFO - '_': '/tools/buildbot/bin/python'} 01:32:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:32:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:32:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:32:26 INFO - Installing collected packages: mozsystemmonitor 01:32:26 INFO - Running setup.py install for mozsystemmonitor 01:32:26 INFO - Successfully installed mozsystemmonitor 01:32:26 INFO - Cleaning up... 01:32:26 INFO - Return code: 0 01:32:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:32:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf89030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1247570>, '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 0x1248470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1248900>, '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': '52faae308a556c440401f8e5000001e8-1467361440.663428-638311842', '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 01:32:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:32:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:32:26 INFO - Using env: {'DISPLAY': ':0', 01:32:26 INFO - 'HOME': '/home/cltbld', 01:32:26 INFO - 'LANG': 'en_US.UTF-8', 01:32:26 INFO - 'LANGUAGE': 'en_US:en', 01:32:26 INFO - 'LOGNAME': 'cltbld', 01:32:26 INFO - 'MAIL': '/var/mail/cltbld', 01:32:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:26 INFO - 'MOZ_NO_REMOTE': '1', 01:32:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:26 INFO - 'NO_EM_RESTART': '1', 01:32:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:26 INFO - 'PWD': '/builds/slave/test', 01:32:26 INFO - 'SHELL': '/bin/bash', 01:32:26 INFO - 'SHLVL': '1', 01:32:26 INFO - 'TERM': 'linux', 01:32:26 INFO - 'TMOUT': '86400', 01:32:26 INFO - 'USER': 'cltbld', 01:32:26 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467361440.663428-638311842', 01:32:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:26 INFO - '_': '/tools/buildbot/bin/python'} 01:32:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:26 INFO - Downloading/unpacking jsonschema==2.5.1 01:32:26 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 01:32:26 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 01:32:26 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 01:32:26 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 01:32:26 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 01:32:26 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 01:32:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:32:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:32:28 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 01:32:28 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 01:32:28 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 01:32:28 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 01:32:28 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 01:32:28 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 01:32:28 INFO - Downloading functools32-3.2.3-2.tar.gz 01:32:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:32:28 INFO - warning: no files found matching '*.txt' 01:32:28 INFO - no previously-included directories found matching 'build' 01:32:28 INFO - no previously-included directories found matching 'dist' 01:32:28 INFO - no previously-included directories found matching '.git*' 01:32:28 INFO - Installing collected packages: jsonschema, functools32 01:32:28 INFO - Running setup.py install for functools32 01:32:28 INFO - warning: no files found matching '*.txt' 01:32:28 INFO - no previously-included directories found matching 'build' 01:32:28 INFO - no previously-included directories found matching 'dist' 01:32:28 INFO - no previously-included directories found matching '.git*' 01:32:29 INFO - Successfully installed jsonschema functools32 01:32:29 INFO - Cleaning up... 01:32:29 INFO - Return code: 0 01:32:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:32:29 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:29 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:29 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 0xf89030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1247570>, '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 0x1248470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1248900>, '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': '52faae308a556c440401f8e5000001e8-1467361440.663428-638311842', '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 01:32:29 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 01:32:29 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 01:32:29 INFO - Using env: {'DISPLAY': ':0', 01:32:29 INFO - 'HOME': '/home/cltbld', 01:32:29 INFO - 'LANG': 'en_US.UTF-8', 01:32:29 INFO - 'LANGUAGE': 'en_US:en', 01:32:29 INFO - 'LOGNAME': 'cltbld', 01:32:29 INFO - 'MAIL': '/var/mail/cltbld', 01:32:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:29 INFO - 'MOZ_NO_REMOTE': '1', 01:32:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:29 INFO - 'NO_EM_RESTART': '1', 01:32:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:29 INFO - 'PWD': '/builds/slave/test', 01:32:29 INFO - 'SHELL': '/bin/bash', 01:32:29 INFO - 'SHLVL': '1', 01:32:29 INFO - 'TERM': 'linux', 01:32:29 INFO - 'TMOUT': '86400', 01:32:29 INFO - 'USER': 'cltbld', 01:32:29 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467361440.663428-638311842', 01:32:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:29 INFO - '_': '/tools/buildbot/bin/python'} 01:32:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:29 INFO - Downloading/unpacking blobuploader==1.2.4 01:32:29 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 01:32:29 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 01:32:29 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 01:32:29 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 01:32:29 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 01:32:29 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 01:32:31 INFO - Downloading blobuploader-1.2.4.tar.gz 01:32:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:32:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:32:31 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 01:32:31 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 01:32:31 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 01:32:31 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 01:32:31 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 01:32:31 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 01:32:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:32:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:32:31 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 01:32:31 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 01:32:31 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 01:32:31 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 01:32:31 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 01:32:31 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 01:32:31 INFO - Downloading docopt-0.6.1.tar.gz 01:32:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:32:31 INFO - Installing collected packages: blobuploader, requests, docopt 01:32:31 INFO - Running setup.py install for blobuploader 01:32:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:32:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:32:32 INFO - Running setup.py install for requests 01:32:32 INFO - Running setup.py install for docopt 01:32:32 INFO - Successfully installed blobuploader requests docopt 01:32:32 INFO - Cleaning up... 01:32:32 INFO - Return code: 0 01:32:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:32:32 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:32 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:32 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 0xf89030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1247570>, '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 0x1248470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1248900>, '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': '52faae308a556c440401f8e5000001e8-1467361440.663428-638311842', '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 01:32:32 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 01:32:32 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 01:32:32 INFO - Using env: {'DISPLAY': ':0', 01:32:32 INFO - 'HOME': '/home/cltbld', 01:32:32 INFO - 'LANG': 'en_US.UTF-8', 01:32:32 INFO - 'LANGUAGE': 'en_US:en', 01:32:32 INFO - 'LOGNAME': 'cltbld', 01:32:32 INFO - 'MAIL': '/var/mail/cltbld', 01:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:32 INFO - 'MOZ_NO_REMOTE': '1', 01:32:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:32 INFO - 'NO_EM_RESTART': '1', 01:32:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:32 INFO - 'PWD': '/builds/slave/test', 01:32:32 INFO - 'SHELL': '/bin/bash', 01:32:32 INFO - 'SHLVL': '1', 01:32:32 INFO - 'TERM': 'linux', 01:32:32 INFO - 'TMOUT': '86400', 01:32:32 INFO - 'USER': 'cltbld', 01:32:32 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467361440.663428-638311842', 01:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:32 INFO - '_': '/tools/buildbot/bin/python'} 01:32:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:32:32 INFO - Running setup.py (path:/tmp/pip-6NxNqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:32:32 INFO - Running setup.py (path:/tmp/pip-_A74ST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:32:32 INFO - Running setup.py (path:/tmp/pip-6yy0D2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:32:32 INFO - Running setup.py (path:/tmp/pip-aCe3yx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:32:33 INFO - Running setup.py (path:/tmp/pip-7FpxEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:32:33 INFO - Running setup.py (path:/tmp/pip-c3F0Zj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:32:33 INFO - Running setup.py (path:/tmp/pip-xiDQH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:32:33 INFO - Running setup.py (path:/tmp/pip-vxhY5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:32:33 INFO - Running setup.py (path:/tmp/pip-eFW9mG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:32:33 INFO - Running setup.py (path:/tmp/pip-YtgAvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:32:33 INFO - Running setup.py (path:/tmp/pip-B53qxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:32:33 INFO - Running setup.py (path:/tmp/pip-TFxyzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:32:33 INFO - Running setup.py (path:/tmp/pip-yiCwCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:32:33 INFO - Running setup.py (path:/tmp/pip-oTDzuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:32:33 INFO - Running setup.py (path:/tmp/pip-woCdb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:32:33 INFO - Running setup.py (path:/tmp/pip-ebjn4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:32:33 INFO - Running setup.py (path:/tmp/pip-olgzHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:32:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:32:33 INFO - Running setup.py install for manifestparser 01:32:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:32:34 INFO - Running setup.py install for mozcrash 01:32:34 INFO - Running setup.py install for mozdebug 01:32:34 INFO - Running setup.py install for mozdevice 01:32:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:32:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:32:34 INFO - Running setup.py install for mozfile 01:32:34 INFO - Running setup.py install for mozhttpd 01:32:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:32:34 INFO - Running setup.py install for mozinfo 01:32:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:32:34 INFO - Running setup.py install for mozInstall 01:32:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:32:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:32:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:32:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:32:34 INFO - Running setup.py install for mozleak 01:32:34 INFO - Running setup.py install for mozlog 01:32:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:32:35 INFO - Running setup.py install for moznetwork 01:32:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:32:35 INFO - Running setup.py install for mozprocess 01:32:35 INFO - Running setup.py install for mozprofile 01:32:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:32:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:32:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:32:35 INFO - Running setup.py install for mozrunner 01:32:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:32:35 INFO - Running setup.py install for mozscreenshot 01:32:35 INFO - Running setup.py install for moztest 01:32:35 INFO - Running setup.py install for mozversion 01:32:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:32:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:32:35 INFO - Cleaning up... 01:32:35 INFO - Return code: 0 01:32:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:32: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:35 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 0xf89030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1247570>, '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 0x1248470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1248900>, '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': '52faae308a556c440401f8e5000001e8-1467361440.663428-638311842', '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 01:32:35 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 01:32:35 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 01:32:35 INFO - Using env: {'DISPLAY': ':0', 01:32:35 INFO - 'HOME': '/home/cltbld', 01:32:35 INFO - 'LANG': 'en_US.UTF-8', 01:32:35 INFO - 'LANGUAGE': 'en_US:en', 01:32:35 INFO - 'LOGNAME': 'cltbld', 01:32:35 INFO - 'MAIL': '/var/mail/cltbld', 01:32:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:35 INFO - 'MOZ_NO_REMOTE': '1', 01:32:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:35 INFO - 'NO_EM_RESTART': '1', 01:32:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:35 INFO - 'PWD': '/builds/slave/test', 01:32:35 INFO - 'SHELL': '/bin/bash', 01:32:35 INFO - 'SHLVL': '1', 01:32:35 INFO - 'TERM': 'linux', 01:32:35 INFO - 'TMOUT': '86400', 01:32:35 INFO - 'USER': 'cltbld', 01:32:35 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467361440.663428-638311842', 01:32:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:35 INFO - '_': '/tools/buildbot/bin/python'} 01:32:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:32:36 INFO - Running setup.py (path:/tmp/pip-ynG7MH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:32:36 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)) 01:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:32:36 INFO - Running setup.py (path:/tmp/pip-10STXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:32:36 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)) 01:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:32:36 INFO - Running setup.py (path:/tmp/pip-_dkHYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:32:36 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)) 01:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:32:36 INFO - Running setup.py (path:/tmp/pip-oviQHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:32:36 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)) 01:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:32:36 INFO - Running setup.py (path:/tmp/pip-Uuio8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:32:36 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)) 01:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:32:36 INFO - Running setup.py (path:/tmp/pip-_qv5L1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:32:36 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)) 01:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:32:36 INFO - Running setup.py (path:/tmp/pip-6Yy5UM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:32:36 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)) 01:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:32:36 INFO - Running setup.py (path:/tmp/pip-1NL5Uq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:32:36 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)) 01:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:32:36 INFO - Running setup.py (path:/tmp/pip-LWzDpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:32:36 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)) 01:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:32:36 INFO - Running setup.py (path:/tmp/pip-pL7bzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:32:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 01:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:32:36 INFO - Running setup.py (path:/tmp/pip-BXiyDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:32:36 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)) 01:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:32:36 INFO - Running setup.py (path:/tmp/pip-WahCAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:32:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 01:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:32:36 INFO - Running setup.py (path:/tmp/pip-nLeG6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:32:36 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)) 01:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:32:36 INFO - Running setup.py (path:/tmp/pip-aSmCDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:32:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 01:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:32:37 INFO - Running setup.py (path:/tmp/pip-DLBWY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:32:37 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)) 01:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:32:37 INFO - Running setup.py (path:/tmp/pip-4Z4SF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:32:37 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)) 01:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:32:37 INFO - Running setup.py (path:/tmp/pip-w3XIJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:32:37 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)) 01:32:37 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)) 01:32:37 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)) 01:32:37 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)) 01:32:37 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)) 01:32:37 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)) 01:32:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:32:37 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 01:32:37 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 01:32:37 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 01:32:37 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 01:32:37 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 01:32:37 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 01:32:39 INFO - Downloading blessings-1.6.tar.gz 01:32:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:32:39 INFO - Installing collected packages: blessings 01:32:39 INFO - Running setup.py install for blessings 01:32:39 INFO - Successfully installed blessings 01:32:39 INFO - Cleaning up... 01:32:39 INFO - Return code: 0 01:32:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:32:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:32:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:32:39 INFO - Reading from file tmpfile_stdout 01:32:39 INFO - Current package versions: 01:32:39 INFO - argparse == 1.2.1 01:32:39 INFO - blessings == 1.6 01:32:39 INFO - blobuploader == 1.2.4 01:32:39 INFO - docopt == 0.6.1 01:32:39 INFO - functools32 == 3.2.3-2 01:32:39 INFO - jsonschema == 2.5.1 01:32:39 INFO - manifestparser == 1.1 01:32:39 INFO - mozInstall == 1.12 01:32:39 INFO - mozcrash == 0.17 01:32:39 INFO - mozdebug == 0.1 01:32:39 INFO - mozdevice == 0.48 01:32:39 INFO - mozfile == 1.2 01:32:39 INFO - mozhttpd == 0.7 01:32:39 INFO - mozinfo == 0.9 01:32:39 INFO - mozleak == 0.1 01:32:39 INFO - mozlog == 3.2 01:32:39 INFO - moznetwork == 0.27 01:32:39 INFO - mozprocess == 0.22 01:32:39 INFO - mozprofile == 0.28 01:32:39 INFO - mozrunner == 6.11 01:32:39 INFO - mozscreenshot == 0.1 01:32:39 INFO - mozsystemmonitor == 0.3 01:32:39 INFO - moztest == 0.7 01:32:39 INFO - mozversion == 1.4 01:32:39 INFO - psutil == 3.1.1 01:32:39 INFO - requests == 1.2.3 01:32:39 INFO - wsgiref == 0.1.2 01:32:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:32: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:39 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 0xf89030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1247570>, '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 0x1248470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1248900>, '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': '52faae308a556c440401f8e5000001e8-1467361440.663428-638311842', '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 01:32:39 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 01:32:39 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 01:32:39 INFO - Using env: {'DISPLAY': ':0', 01:32:39 INFO - 'HOME': '/home/cltbld', 01:32:39 INFO - 'LANG': 'en_US.UTF-8', 01:32:39 INFO - 'LANGUAGE': 'en_US:en', 01:32:39 INFO - 'LOGNAME': 'cltbld', 01:32:39 INFO - 'MAIL': '/var/mail/cltbld', 01:32:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:39 INFO - 'MOZ_NO_REMOTE': '1', 01:32:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:39 INFO - 'NO_EM_RESTART': '1', 01:32:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:39 INFO - 'PWD': '/builds/slave/test', 01:32:39 INFO - 'SHELL': '/bin/bash', 01:32:39 INFO - 'SHLVL': '1', 01:32:39 INFO - 'TERM': 'linux', 01:32:39 INFO - 'TMOUT': '86400', 01:32:39 INFO - 'USER': 'cltbld', 01:32:39 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467361440.663428-638311842', 01:32:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:39 INFO - '_': '/tools/buildbot/bin/python'} 01:32:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:39 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)) 01:32:39 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)) 01:32:39 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)) 01:32:39 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)) 01:32:39 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)) 01:32:39 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)) 01:32:39 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)) 01:32:39 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)) 01:32:39 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)) 01:32:39 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)) 01:32:39 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)) 01:32:39 INFO - Cleaning up... 01:32:39 INFO - Return code: 0 01:32:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:32: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf89030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1247570>, '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 0x1248470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1248900>, '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': '52faae308a556c440401f8e5000001e8-1467361440.663428-638311842', '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 01:32: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', 'jsonschema'] in /builds/slave/test/build 01:32: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 jsonschema 01:32:39 INFO - Using env: {'DISPLAY': ':0', 01:32:39 INFO - 'HOME': '/home/cltbld', 01:32:39 INFO - 'LANG': 'en_US.UTF-8', 01:32:39 INFO - 'LANGUAGE': 'en_US:en', 01:32:39 INFO - 'LOGNAME': 'cltbld', 01:32:39 INFO - 'MAIL': '/var/mail/cltbld', 01:32:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:39 INFO - 'MOZ_NO_REMOTE': '1', 01:32:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:39 INFO - 'NO_EM_RESTART': '1', 01:32:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:39 INFO - 'PWD': '/builds/slave/test', 01:32:39 INFO - 'SHELL': '/bin/bash', 01:32:39 INFO - 'SHLVL': '1', 01:32:39 INFO - 'TERM': 'linux', 01:32:39 INFO - 'TMOUT': '86400', 01:32:39 INFO - 'USER': 'cltbld', 01:32:39 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467361440.663428-638311842', 01:32:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:39 INFO - '_': '/tools/buildbot/bin/python'} 01:32:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:32:40 INFO - Cleaning up... 01:32:40 INFO - Return code: 0 01:32:40 INFO - Running post-action listener: _resource_record_post_action 01:32:40 INFO - Running post-action listener: _start_resource_monitoring 01:32:40 INFO - Starting resource monitoring. 01:32:40 INFO - ##### 01:32:40 INFO - ##### Finished create-virtualenv step (success) 01:32:40 INFO - ##### 01:32:40 INFO - ##### 01:32:40 INFO - ##### Running install step. 01:32:40 INFO - ##### 01:32:40 INFO - Running pre-action listener: _resource_record_pre_action 01:32:40 INFO - Running main action method: install 01:32:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:32:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:32:40 INFO - Reading from file tmpfile_stdout 01:32:40 INFO - Detecting whether we're running mozinstall >=1.0... 01:32:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:32:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:32:40 INFO - Reading from file tmpfile_stdout 01:32:40 INFO - Output received: 01:32:40 INFO - Usage: mozinstall [options] installer 01:32:40 INFO - Options: 01:32:40 INFO - -h, --help show this help message and exit 01:32:40 INFO - -d DEST, --destination=DEST 01:32:40 INFO - Directory to install application into. [default: 01:32:40 INFO - "/builds/slave/test"] 01:32:40 INFO - --app=APP Application being installed. [default: firefox] 01:32:40 INFO - mkdir: /builds/slave/test/build/application 01:32:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:32:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:32:56 INFO - Reading from file tmpfile_stdout 01:32:56 INFO - Output received: 01:32:56 INFO - /builds/slave/test/build/application/firefox/firefox 01:32:56 INFO - Running post-action listener: _resource_record_post_action 01:32:56 INFO - ##### 01:32:56 INFO - ##### Finished install step (success) 01:32:56 INFO - ##### 01:32:56 INFO - ##### 01:32:56 INFO - ##### Running run-tests step. 01:32:56 INFO - ##### 01:32:56 INFO - Running pre-action listener: _resource_record_pre_action 01:32:56 INFO - Running main action method: run_tests 01:32:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:32:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:32:56 INFO - Python 2.7.3 01:32:56 INFO - Return code: 0 01:32:56 INFO - grabbing minidump binary from tooltool 01:32:56 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:56 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 0x1247570>, '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 0x1248470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1248900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:32:56 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 01:32:56 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 01:32:56 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 01:32:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:32:56 INFO - Return code: 0 01:32:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:32:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:32:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:32:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:32:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:32:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 01:32:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 01:32:56 INFO - Using env: {'DISPLAY': ':0', 01:32:56 INFO - 'HOME': '/home/cltbld', 01:32:56 INFO - 'LANG': 'en_US.UTF-8', 01:32:56 INFO - 'LANGUAGE': 'en_US:en', 01:32:56 INFO - 'LOGNAME': 'cltbld', 01:32:56 INFO - 'MAIL': '/var/mail/cltbld', 01:32:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:32:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:32:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:56 INFO - 'MOZ_NO_REMOTE': '1', 01:32:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:32:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:56 INFO - 'NO_EM_RESTART': '1', 01:32:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:56 INFO - 'PWD': '/builds/slave/test', 01:32:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:32:56 INFO - 'SHELL': '/bin/bash', 01:32:56 INFO - 'SHLVL': '1', 01:32:56 INFO - 'TERM': 'linux', 01:32:56 INFO - 'TMOUT': '86400', 01:32:56 INFO - 'USER': 'cltbld', 01:32:56 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467361440.663428-638311842', 01:32:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:56 INFO - '_': '/tools/buildbot/bin/python'} 01:32:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 01:32:56 INFO - mozversion application_buildid: 20160701000923 01:32:56 INFO - mozversion application_changeset: cd5a30817ea4389a01482ef9df5fb0017d26d36c 01:32:56 INFO - mozversion application_display_name: Nightly 01:32:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:32:56 INFO - mozversion application_name: Firefox 01:32:56 INFO - mozversion application_remotingname: firefox 01:32:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 01:32:56 INFO - mozversion application_vendor: Mozilla 01:32:56 INFO - mozversion application_version: 50.0a1 01:32:56 INFO - mozversion platform_buildid: 20160701000923 01:32:56 INFO - mozversion platform_changeset: cd5a30817ea4389a01482ef9df5fb0017d26d36c 01:32:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 01:32:56 INFO - mozversion platform_version: 50.0a1 01:32:56 INFO - using testdate: 1467361976 01:32:56 INFO - actual date: 1467361976 01:32:56 INFO - starting webserver on 'localhost:38853' 01:32:56 INFO - SUITE-START | Running 2 tests 01:32:56 INFO - TEST-START | dromaeo_css 01:32:56 INFO - operating with platform_type : linux_ 01:32:56 INFO - Initialising browser for dromaeo_css test... 01:32:56 INFO - TEST-INFO | started process 8578 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBSHQ3z/profile http://localhost:38853/getInfo.html) 01:33:02 INFO - PROCESS | 8578 | __metrics Screen width/height:1600/1200 01:33:02 INFO - PROCESS | 8578 | colorDepth:24 01:33:02 INFO - PROCESS | 8578 | Browser inner width/height: 1024/697 01:33:02 INFO - PROCESS | 8578 | __metrics 01:33:02 ERROR - PROCESS | 8578 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 01:33:03 INFO - TEST-INFO | 8578: exit 0 01:33:03 INFO - Browser initialized. 01:33:03 INFO - Running cycle 1/1 for dromaeo_css test... 01:33:03 INFO - TEST-INFO | started process 8699 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBSHQ3z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:33:15 INFO - PROCESS | 8699 | RSS: Main: 169238528 01:33:15 INFO - PROCESS | 8699 | 01:34:05 INFO - PROCESS | 8699 | 1467362045186 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] 01:36:16 INFO - PROCESS | 8699 | Cycle 1(1): loaded http://localhost:38853/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38853/tests/dromaeo/cssquery-ext.html) 01:36:18 INFO - PROCESS | 8699 | RSS: Main: 170094592 01:36:18 INFO - PROCESS | 8699 | 01:39:20 INFO - PROCESS | 8699 | Cycle 1(1): loaded http://localhost:38853/tests/dromaeo/cssquery-ext.html (next: http://localhost:38853/tests/dromaeo/cssquery-jquery.html) 01:39:20 INFO - PROCESS | 8699 | RSS: Main: 168820736 01:39:20 INFO - PROCESS | 8699 | 01:42:22 INFO - PROCESS | 8699 | Cycle 1(1): loaded http://localhost:38853/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38853/tests/dromaeo/cssquery-mootools.html) 01:42:23 INFO - PROCESS | 8699 | RSS: Main: 172122112 01:42:23 INFO - PROCESS | 8699 | 01:45:25 INFO - PROCESS | 8699 | Cycle 1(1): loaded http://localhost:38853/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38853/tests/dromaeo/cssquery-prototype.html) 01:45:25 INFO - PROCESS | 8699 | RSS: Main: 168357888 01:45:25 INFO - PROCESS | 8699 | 01:48:28 INFO - PROCESS | 8699 | Cycle 1(1): loaded http://localhost:38853/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38853/tests/dromaeo/cssquery-yui.html) 01:48:29 INFO - PROCESS | 8699 | RSS: Main: 169906176 01:48:29 INFO - PROCESS | 8699 | 01:51:31 INFO - PROCESS | 8699 | Cycle 1(1): loaded http://localhost:38853/tests/dromaeo/cssquery-yui.html (next: http://localhost:38853/tests/dromaeo/cssquery-dojo.html) 01:51:32 INFO - PROCESS | 8699 | RSS: Main: 170782720 01:51:32 INFO - PROCESS | 8699 | 01:51:32 INFO - PROCESS | 8699 | __start_tp_report 01:51:32 INFO - PROCESS | 8699 | _x_x_mozilla_page_load 01:51:32 INFO - PROCESS | 8699 | _x_x_mozilla_page_load_details 01:51:32 INFO - PROCESS | 8699 | |i|pagename|runs| 01:51:32 INFO - PROCESS | 8699 | |0;dojo.html;2579.264909500793;2641.6791604197897;2651.655284812974;2661.042024871046;2673.879675414606;4697.718136911783;4715.198416269234;4784.593309568682;4789.401324834395;4796.784144713488;4687.992081702433;4702.576768090871;4713.740744259065;4789.5210478952085;4805.063012712522;4320.416743739586;4362.323839804835;4379.321205213197;4400.713953593022;4439.311906654458;4435.4233949586505;4439.977800110995;4458.4204053473;4506.324051392285;4525.773711314438;4328.285832837578;4363.52001279859;4401.075774087413;4401.075774087445;4429.911401771947;4405.713628614162;4413.5365786592265;4420.602145806861;4439.223135951195;4462.12988467249;4305.160493703729;4368.410264614268;4394.033312671208;4428.512863585003;4478.216312145361;4725.787339569728;4811.494793046715;4827.396575428072;4833.564979151894;4864.440589332236;5072.163093089635;5131.204663277198;5136.126858434075;5151.227315902607;5189.818356357547;5041.067402530543;5071.087204303224;5102.923456148161;5134.0758663440565;5134.922976155361;4745.311929770164;4766.475687674353;4776.2119250324;4791.520847915181;4821.2045012573235;5242.056429842665;5250.3962044364625;5254.3169387979315;5269.420363759983;5271.499207575351;4990.725510096907;5031.823886163967;5039.546440820271;5057.190849464142;5073.735169712681;4975.875603109879;4998.225275082295;5119.87200319995;5135.2553879687985;5167;4992.500749925051;5025.221090730943;5030.4215015272985;5075.619328550373;5086.745662716923;4937.629677774181;5015.14742493777;5029.119904016782;5030.2957585938;5052.974735126374;4284.271673815459;4295;4330.220560299176;4331;4348.369486424514;3736.962630373716;3743.4384842273876;3749.4375843623675;3779.8677046303246;3784.526934133233;4270.359446083113;4366.039471316305;4375.431193944767;4397.120575884772;4473.888152796141;5101.413337466239;5128.974355128275;5138.332016837787;5142.820001300011;5174.818881339135;4315;4378.912421751547;4407.360932664746;4420.84527041552;4449.688521803443;4481.551844815493;4536.251518499476;4568.017876156642;4596.264597664358;4599.08018396322;4811.446683631427;4814.1815891297865;4828.686135401258;4837.95162048375;4861.027794441196;5090;5114.053900028507;5121.692698437957;5135.38375394955;5165.483451654804;4715.457722361835;4763.928541071818;4800.3279540863605;4825.517448255287;4829.613630909589;5059.19052951526;5062.240663900445;5085.694858308513;5128.974355128201;5162.819301324435;5033.949660503348;5143.871403214949;5148.536631703165;5151.304573882628;5152.5877929766275;4813.109574728686;4878.804847806048;4928.556429921325;4987.526185012418;4995.225740010304;4911.9754401227765;4970.130227210151;4976.377952755905;4978.726170060681;4979.626528010342;4896.167651499325;4905.950940490549;4910.116179087799;4926.3842019747535;4952.182889823139;4872.4153101628035;4930;4956.182229932165;4957.950420495893;4973.378327709036;4855.1260773061185;4858.878528036827;4881.072596206709;4885.5358740919555;4889.3888263967 01:51:32 INFO - PROCESS | 8699 | |1;ext.html;568.7270110347033;570.426721145249;571.6655756382517;578.7569220927212;596.207044630641;26785;27190.86404567977;38666;39954.60045399545;39993.8000309998;39528;40023;40033.79983100088;40087.79956100215;40307.19385612293;7731.072271327449;7864.331531819802;7866.134725180225;7913.28780409763;7938.364930805551;7747.8450430991625;7828.452008359417;7829.412794040441;7831.412644051719;7841.294283514482;7856.096548896864;7874;7881.05427348719;7881.881771773428;7902.486338388015;7761.185075567068;7811.453198276123;7813.726519571787;7841.607919603997;7850.411219158557;7704.499207551491;7710.57591832449;7756.379489640815;7756.689732410697;7830.060392752906;37070;37167.07082322936;37195.62804371949;37333.25333493342;37590;3178.173674844534;3240.5949256342956;3276.950845737316;3386.4243078676686;3610.2418492116685;28448.57327140074;28837.855810721023;29122.12633620995;29158.125256242347;29772.957946471768;3312.9171770705684;3317.817520036397;3354.748393870445;3357.8824741133944;3374.0552645259368;175539;176514.1174294133;176895;177258;177996;48748.5125148751;48879.75560122177;48888.26667599989;48909.532714018635;48924.510754892;32084;32909.83545082259;33042.66957330396;34891.65108348884;35139.82430087833;13959.371828267753;14027.088239264414;14122.788158177636;14179.14925104497;14201.502947396792;10511.632092876713;10681.89318106809;10697.304675196086;10742.677719668422;10789.892101079045;17665.911670441565;17672.55818604545;17794.288228470716;17959.910200449176;17988;6854.828629284208;6876.484263680144;6899.379055884994;6945.479089068239;7041.859162816715;837.4054421360902;908.1936815240937;1039.9844002339971;1043.8538604595362;1050.1546255264432;27478.862605686845;27900;28027.439451210863;28101.43797124087;28636.42727145487;965.1624224779127;973.9707808765748;1009.7980403919246;1025.620520407454;1043.8121138195197;14506.202158881151;14934.775978360334;15035.624109397353;15048.548543543493;15061.748004606177;394532;397719;399961;400666;400679;31637.52543711846;31656.525152122736;31790.2052448686;31798;31812.363752724817;1153.3656488931053;1183.1540448579308;1185.4428418643051;1200.4717924113363;1201.813718873576;26477.602835957863;27675.86162069177;27841.44317113687;27870.3032424191;27878.16365509038;41293;41413;41773.37339939843;41786.58213417949;41851.651867851106;322498;322729;323290;323307;325600;24642.630360544248;24646.63030054515;24828.875855620605;25071.749282506942;25333.87333063323;40968.59031409767;41414.1717165661;41582.58417415787;42094;42404.363934540386;34580.308393832485;35834.82082589675;35893;36500.26999460049;36743;35221.47167792434;35539.28921421505;35768.463473047406;36255;36331.63668363282;34959.65040349564;35067.64932350644;35977.64022359743;36168;38875.80562097171;29993.55009674813;32391.51412728764;32709.836450817595;32904;33147.33705325928;24959.75040249647;25244.368890777143;25244.465774791912;25666.486670266862;25872.482550349265 01:51:32 INFO - PROCESS | 8699 | |2;jquery.html;356.6380124173962;362.09656906019484;363.2535140286711;371.70263788968816;381.8243607940347;16134.273957671903;17223.22495487703;18170.091495425208;18172.09139543024;18213.18040688169;16438.260278287475;16541.255643496042;17595.032273224966;17647.20587573559;17773.64452710945;4977.601791856643;5160.767765450545;5186.636935414523;5203.375594928614;5210.322658054467;3751.7936513491745;5021.297018417425;5616.663000219979;5921.289445266574;5929.851753706149;5899.056151015839;5902.2622172228475;5916.349201587822;5976.462118409342;5982.461578457938;5830.125481177814;5944.732487038051;5972.0444728843395;5973.432523910222;5992.640441573498;5065.201853342048;5202.583793296565;5235.528802407764;5247.842564723026;5259.15853463444;21107.40986750434;21663.891680541656;21807.563848722937;21811.563768724696;22008.779912200993;1971.2115153938396;2011.225678113922;2033.5119571302928;2074.6161960037443;2140.882251476168;13319.933400333033;13378.130421522666;13411;13417.32913354338;14002;1721.0878234535592;1754.9122543872754;1778.9528821930082;1790.355472030068;1801.927922883083;65912.71567348107;67060.3293967059;68660.31339686639;69003.3099669002;69554.65222673854;9497.90502094984;9515.191208747334;9875.259355548218;10096.34373765703;10207.7448063799;13524.647535246397;13598.524051658342;13701.931490342484;13720.108192967426;13721.862781372258;7016.824579385454;7022.192447868459;7058.400035996895;7131.750388736369;7243.203247642755;6270.655113968775;6316.178896743486;6351.745930162834;6377.936220637827;6605.141331626858;6072.271327440647;6224.253089629274;6319.399657032666;6366.522510811615;6396.808095757135;1582.7784110224577;1645.3747575921072;1767.469759072273;1787.9553011174564;1788.7764029496313;868.1839071272983;885.2431171348533;920.8756817829641;944.282345417474;1011.7318910488726;16832;16973.405930792364;17714.734278985827;18319;19187.040647967548;835.4235577451539;848.5926755157559;883.88067610873;894.3739382432324;910.822389634015;9684.903150968541;9873.308868379288;9944.303898727165;10010.54952527138;10046.547905344278;403072;404441;420738;433535;434724;49471.75264123656;79557.60221198857;83156;83620.58189709013;85243.14756852352;927.1238679447991;941.9199368053792;953.6137864165163;954.1365064616533;964.9855252171224;15460.9226953869;15937.282822272793;16054.67890642204;16163.838361616234;16425.425110121087;30255.546166807075;32527.349453010334;37760.62239377571;38905.6109438902;39801.80099099486;52931.73534132459;53801.92396152133;54266.18600720914;54830;55170.172447412515;7476;7547.245275472409;7693.115291741297;7717.6527056281475;7785.299323060952;10706.357618542912;12214.75570488603;12363.69090772738;12396.132270740962;12665.556705515262;9710.465924374228;10422.843657344994;10455.268131230741;10600.098991585493;10648.414337211529;10140.645077422254;10445.529951152064;10477.161827053666;10684.198685098494;10685.252032357661;10377.11794497446;10449.328107502763;10532.315399499008;10577.682669519927;10813.351198928089;6504.479641628753;6983.546069505466;7681.462297639112;7780.805479863048;7891.210878912063;9611.807763844823;9989.001099890243;10324.948375258076;10768.838467422838;10865.239433239598 01:51:32 INFO - PROCESS | 8699 | |3;mootools.html;1359.272789057854;1401.1312985948714;1454.1275234859086;1654.1811803157439;1664.459050808486;6824.078749368834;7395.334419902208;7521.51110177838;7819.530828150308;7962.283394494501;7587.962060189705;7753.92246077539;7847.411444141684;7859.764207073797;7898.091719452264;2187.912483500662;2228;2228.4651683595903;2228.5988522066023;2239.8096161826265;2158.3740715192575;2179.063002908749;2243.8541494802785;2245.079517397867;2251.1783199132365;2227.24273746926;2233.296511598849;2235.485838257202;2238.1271304191378;2269.863808171515;2168.1977668262766;2175.7824217578273;2181.334692918659;2192.8684278943233;2208.381653137124;2097.0877668214375;2131.8507704460694;2151.1610471915965;2152.1283880028614;2162.76209616942;7796.298333149987;7824.4131690122895;7839.25527074927;7891.131975482693;7930.405219608552;4452.0205554777895;4515.345274935116;4558.749268790215;4563.794629241659;4587.24310488769;2851.187411587708;2865.8423786691724;2904.1868276882506;2962.5852380666724;2989.880404783806;944.5702205496483;951.3198063384713;966.6906589891238;995.3629677006721;995.3729150635126;10186.745331366701;10249.743756406075;10262.486875656188;10310.07209351162;10402.167826573856;3956.5054368203973;4082.2447847148374;4182.435371224907;4191.161767646483;4212.873613791591;8850.468971861708;8855.512946787989;8863.113688631085;8924.464532128093;9005.864912026325;4546.0680560485025;4565.817367305271;4574.725516468956;4587.77061146948;4593.885152871205;3661.7436779425716;3984.621460961204;4101.2207680540605;4169.061961058737;4175.853845115406;3627.328944145289;3639.090227443139;3718.1819999600584;3731.2164445466215;3762.3227818992295;1160.4255893332854;1177.3995262416058;1180.2505409065304;1181.0846593889632;1183;808.3210103513077;823.7775800533942;839.5676226743232;863.0808189278398;873.8077622922947;4839.249916262985;4856.247281671346;4958.504149585085;5012.072766538129;5114.897702045938;392.770229415795;394.4083874188717;398.6671129606753;401.0295085892148;401.06151605243286;3451.4650229214512;3485.5991560970815;3498.0205542448157;3537.2925414917117;3577.4633804929467;8852.557372131369;9207.953960230156;9260.21288190498;9507.952460237793;9518.095780900803;9493.288003399774;9518.809623807623;9523.666671666459;9523.857142142873;9530.52347382628;6966.094407726963;7121.964390178119;7122.821929451701;7148.642567871586;7167.534110282815;5239.44985776488;5383.192521121863;5424.159255315432;5539.196816461671;5602.327720673546;8915.197632213132;8977.28181745472;8999.685011024845;9003.234725048444;9024.052474490347;8926.598303076247;8962.775930601787;8974.19232269099;8988.32587555949;8996.235319997873;6147.815565533041;6595.208574971034;6769.627670478171;6837.965810170917;6869.278725733726;7503.662335195038;7507.399408047452;7521.323080922743;7539.962300188683;7562.848743025219;6692.130023096966;6928.16861976566;6945.895811562932;6964.338387853146;6979;6501.544891857525;6503.349665033459;6531.11829902976;6545.985372267306;6695.4978376620975;5853.180554722428;5915.142304365929;5917.082852157922;5941;5970.492508136857;4365.869023929287;4380.7590582517;4402.141582391403;4486.955130448654;4493.101379724134;4486.416765820422;4556.430446194226;4660.6970546914345;4683.1804434223195;4705.76471176433 01:51:32 INFO - PROCESS | 8699 | |4;prototype.html;288.72138386457067;289.83334582615004;293.0724257724303;301.55821721178467;301.78120862374766;4950.737561921714;5033.672811267265;5101.668391554546;5129.435762066169;5155.736844473105;5036.471170527097;5052.368453943257;5092.363454568179;5093.9235911461265;5106;3920.568992317812;3976.1252524444576;4039.7576145431367;4074.144429669758;4081;3898.688104951597;3953.881383558498;3958.150131905024;3978.1844721831953;3993.4608827808165;3954.8418063277577;3987.7806720630356;3993.4009898515164;4000.419939108842;4013.351188215778;3903.4925459690344;3991.521017477892;3999.440078389028;4002;4009.218202450523;3525.964740352589;3543.698785603227;3545.7340699447645;3548.361294966905;3573.338932297507;4835.613150947951;4966.50334966504;4974.204127339644;4978.178600530908;5070.746462676888;4566.862994110182;4571.657125715585;4583.839565615188;4587.288970209623;4614.3770590970125;5278.683279003272;5282.418933917266;5291.735413229361;5300.310959575269;5362.605722512175;3717.8698745543775;3802.6577608015136;3850.6726928211137;3850.942235866464;3866.574676785551;5592.7762889484375;5641.464060914206;5642.040853054949;5676.1769543416385;5680.488756011938;3909.100906791454;3940.231654827281;3960.9107495438407;3980.1840622672285;3981.2880461401296;3671.9082022949106;3913.471681323042;4038.9596104038583;4041.6160464755803;4042.1915616876154;4462.888427789331;4496.887577810516;4502.054568540578;4505.1440226357545;4524.6832721709825;5278.630495865329;5320.893582128336;5418.187271909166;5450.264214331094;5462.644928079662;1242.782513060211;1307.7319149574314;1323.2655875988726;1328.408858058155;1332.3871019331023;882.302980645283;884.429542944797;901.4906577783662;901.5537309032071;910.2081189365294;4553.681242313006;4560.657950653715;4566.862994110182;4582.77086145698;4611.723296602215;5411.188321751769;5417.59368047398;5511.090670039479;5530.640508366943;5543.1685247213245;4444.422225110779;4617.699849509839;4629.8842528936375;4655.74393408359;4665.160271151158;2601.687797464316;2615.620734993415;2629.4346715456268;2645.9867700661375;2671.170248379866;4485.59629633328;4585.770711464414;4598.3102534620075;4613.76931153441;4670.252759558454;4561.901525298334;4875.561709295766;4927.236278376858;4928.841722195281;4964.081644895634;4561.338605902192;4573.725576465423;4585.335126406652;4642.512536183652;4650.906981860277;4777.307290442797;4858.562729354375;4905.730184839726;4910.86377425821;4917.754112294299;4558.908821823611;4710.29345598163;4732.692374995614;4739.241721324572;4757.928631070606;4556.2254416748565;4561.543845615412;4585.73006361853;4615.953840461552;4624.976875115737;3503.3374635276864;3526.800887698195;3526.8236588171003;3533;3543.911402214965;4834.927476087932;4915.606751459946;4920.630952678492;4951.257311403318;5325.733713314241;5143.177091665316;5312.574994000548;5347.807398966405;5355.973220133875;5419.241306217212;5333.359996800409;5362.276092727432;5369.946300537101;5371.811986580451;5375.623706340519;5083.288339632529;5301.416844147064;5309.946900530946;5310.176922577007;5333.73331333424;5387.434319396407;5391.247844450648;5416.783328666967;5417.079096553674;5436;5280.339957505312;5304.496072873071;5317.627766056339;5329.200619907045;5329.7068661224 01:51:32 INFO - PROCESS | 8699 | |5;yui.html;653.5817077070676;684.866451042047;694.1288682703207;711.5979471598547;718.3463048625752;12764.553240636567;13300.268485233308;13741.519046833362;13745.03784735069;14079.225642589654;13398.330083495835;13567.796483052762;13617.523386681469;13618.387172577233;13642.522511712092;624.0545573456218;766.1763604125573;777.657830554557;786.7207141464784;788.6529926832204;791.7387262203488;799.4044436894521;799.8360336131108;801.5951944268137;804.0512195609178;843.6541018182546;843.9029511606152;846.1792061700141;846.2468403121227;847.0597636623343;829.0134739659785;831.1273163178638;832.4547421438967;837.401258100458;839.0267289943666;611.1871211288975;613.745295702283;613.8741557980603;614.7110857896781;614.7940439952621;13965.371558279901;14269.64325891861;14278.571642850731;14282.071665341824;14345.211013394259;14406.71186576273;14489.565313040626;14499.492517761828;14541.636459088502;14610;10604.68185954415;10715.196360272932;10747.78504429907;10843.945780271048;10955.945220273927;3309.12308238317;3342.29811739535;3401.7958922464486;3408.3183363327184;3450.9309813803584;65049;65367.3463265366;65377.67311163414;65399.673001635165;66261.33738662647;10768.138548916068;10902.836457453144;11069;11095.44522773858;11290.153238507144;20112.19551217964;20245;20352.49118772013;20739.170433182804;20805.27181548669;6823.624700641512;6902.378785909293;6969.825754356181;7022.367986881205;7107.573545587281;3699.093722038118;3773.9245215096093;3828.4448754930936;3829.9808500957315;3839.6928245740273;2794.664640243184;2830.462212179679;2849.131015040391;2870.81339712918;2890.262982939379;494.7452062187976;517.3972322244618;519.8154655097461;520.4899198785135;522.2271038862428;560.6916196092133;607.7265230646227;611.7277811373984;622.1165944359021;646.4989633034436;8253.174682531699;8372.958135209406;8501.277391421798;8503.277221436123;8560.443571167854;504.50306448148547;601.036888141458;604.353341924137;611.7886584562591;632.4813652804748;4035.1929614077303;4068.5524592294823;4172;4210.179179949441;4226.513950895686;93065;93239.53380233055;93626.53186734022;97073.5146324278;97376;83488;84055;85503.57248213718;85940;86743.56628216819;76658.6167069161;77229.22770772333;77315.61342193253;78841.60579197182;78915;8109.959450202711;8125.67497300125;8227.13615070409;8296.709615163682;8379.245867871921;44888.32667509925;45332.219470715936;45348.31977520274;45517.77241113773;47040.529594703614;57770.4222957765;57911;60735.39264607297;64253.67873160604;65020;10318.226133040202;10404.479776011018;10406.907274736044;10710.464476776286;10948.671539853816;11061.446927653746;11288.379139147097;11356.375399353115;11541.16748913491;11690.824637630272;10625.574977001143;10799;10842.674719758104;10844.620438284623;11065;9665.130138287588;9986.35088719231;10272.178225741773;10323.587056517956;10712.143028557852;9647.1317581418;9686.51567421612;9941.751456213653;10251.48742562854;10719.571217151226;8358.707445239388;8550.674645429968;8636.265917397091;9121.817563648823;9275.582598782936;8749.956250218707;8803.33974951894;8897.866532002156;9144.497052662167;9163.633454661738 01:51:32 INFO - PROCESS | 8699 | __end_tp_report 01:51:32 INFO - PROCESS | 8699 | __start_cc_report 01:51:32 INFO - PROCESS | 8699 | _x_x_mozilla_cycle_collect,388 01:51:32 INFO - PROCESS | 8699 | __end_cc_report 01:51:32 INFO - PROCESS | 8699 | __startTimestamp1467363092092__endTimestamp 01:51:32 INFO - PROCESS | 8699 | 01:51:32 INFO - PROCESS | 8699 | ------- Summary: start ------- 01:51:32 INFO - PROCESS | 8699 | Number of tests: 6 01:51:32 INFO - PROCESS | 8699 | 01:51:32 INFO - PROCESS | 8699 | [#0] dojo.html Cycles:165 Average:4714.53 Median:4833.56 stddev:496.92 (10.3%) stddev-sans-first:469.36 01:51:32 INFO - PROCESS | 8699 | Values: 2579.3 2641.7 2651.7 2661.0 2673.9 4697.7 4715.2 4784.6 4789.4 4796.8 4688.0 4702.6 4713.7 4789.5 4805.1 4320.4 4362.3 4379.3 4400.7 4439.3 4435.4 4440.0 4458.4 4506.3 4525.8 4328.3 4363.5 4401.1 4401.1 4429.9 4405.7 4413.5 4420.6 4439.2 4462.1 4305.2 4368.4 4394.0 4428.5 4478.2 4725.8 4811.5 4827.4 4833.6 4864.4 5072.2 5131.2 5136.1 5151.2 5189.8 5041.1 5071.1 5102.9 5134.1 5134.9 4745.3 4766.5 4776.2 4791.5 4821.2 5242.1 5250.4 5254.3 5269.4 5271.5 4990.7 5031.8 5039.5 5057.2 5073.7 4975.9 4998.2 5119.9 5135.3 5167.0 4992.5 5025.2 5030.4 5075.6 5086.7 4937.6 5015.1 5029.1 5030.3 5053.0 4284.3 4295.0 4330.2 4331.0 4348.4 3737.0 3743.4 3749.4 3779.9 3784.5 4270.4 4366.0 4375.4 4397.1 4473.9 5101.4 5129.0 5138.3 5142.8 5174.8 4315.0 4378.9 4407.4 4420.8 4449.7 4481.6 4536.3 4568.0 4596.3 4599.1 4811.4 4814.2 4828.7 4838.0 4861.0 5090.0 5114.1 5121.7 5135.4 5165.5 4715.5 4763.9 4800.3 4825.5 4829.6 5059.2 5062.2 5085.7 5129.0 5162.8 5033.9 5143.9 5148.5 5151.3 5152.6 4813.1 4878.8 4928.6 4987.5 4995.2 4912.0 4970.1 4976.4 4978.7 4979.6 4896.2 4906.0 4910.1 4926.4 4952.2 4872.4 4930.0 4956.2 4958.0 4973.4 4855.1 4858.9 4881.1 4885.5 4889.4 01:51:32 INFO - PROCESS | 8699 | 01:51:32 INFO - PROCESS | 8699 | [#1] ext.html Cycles:180 Average:44374.14 Median:34735.98 stddev:82901.10 (238.7%) stddev-sans-first:83068.42 01:51:32 INFO - PROCESS | 8699 | Values: 568.7 570.4 571.7 578.8 596.2 26785.0 27190.9 38666.0 39954.6 39993.8 39528.0 40023.0 40033.8 40087.8 40307.2 7731.1 7864.3 7866.1 7913.3 7938.4 7747.8 7828.5 7829.4 7831.4 7841.3 7856.1 7874.0 7881.1 7881.9 7902.5 7761.2 7811.5 7813.7 7841.6 7850.4 7704.5 7710.6 7756.4 7756.7 7830.1 37070.0 37167.1 37195.6 37333.3 37590.0 3178.2 3240.6 3277.0 3386.4 3610.2 28448.6 28837.9 29122.1 29158.1 29773.0 3312.9 3317.8 3354.7 3357.9 3374.1 175539.0 176514.1 176895.0 177258.0 177996.0 48748.5 48879.8 48888.3 48909.5 48924.5 32084.0 32909.8 33042.7 34891.7 35139.8 13959.4 14027.1 14122.8 14179.1 14201.5 10511.6 10681.9 10697.3 10742.7 10789.9 17665.9 17672.6 17794.3 17959.9 17988.0 6854.8 6876.5 6899.4 6945.5 7041.9 837.4 908.2 1040.0 1043.9 1050.2 27478.9 27900.0 28027.4 28101.4 28636.4 965.2 974.0 1009.8 1025.6 1043.8 14506.2 14934.8 15035.6 15048.5 15061.7 394532.0 397719.0 399961.0 400666.0 400679.0 31637.5 31656.5 31790.2 31798.0 31812.4 1153.4 1183.2 1185.4 1200.5 1201.8 26477.6 27675.9 27841.4 27870.3 27878.2 41293.0 41413.0 41773.4 41786.6 41851.7 322498.0 322729.0 323290.0 323307.0 325600.0 24642.6 24646.6 24828.9 25071.7 25333.9 40968.6 41414.2 41582.6 42094.0 42404.4 34580.3 35834.8 35893.0 36500.3 36743.0 35221.5 35539.3 35768.5 36255.0 36331.6 34959.7 35067.6 35977.6 36168.0 38875.8 29993.6 32391.5 32709.8 32904.0 33147.3 24959.8 25244.4 25244.5 25666.5 25872.5 01:51:32 INFO - PROCESS | 8699 | 01:51:32 INFO - PROCESS | 8699 | [#2] jquery.html Cycles:180 Average:25429.42 Median:427136.50 stddev:69068.71 (16.2%) stddev-sans-first:69236.81 01:51:32 INFO - PROCESS | 8699 | Values: 356.6 362.1 363.3 371.7 381.8 16134.3 17223.2 18170.1 18172.1 18213.2 16438.3 16541.3 17595.0 17647.2 17773.6 4977.6 5160.8 5186.6 5203.4 5210.3 3751.8 5021.3 5616.7 5921.3 5929.9 5899.1 5902.3 5916.3 5976.5 5982.5 5830.1 5944.7 5972.0 5973.4 5992.6 5065.2 5202.6 5235.5 5247.8 5259.2 21107.4 21663.9 21807.6 21811.6 22008.8 1971.2 2011.2 2033.5 2074.6 2140.9 13319.9 13378.1 13411.0 13417.3 14002.0 1721.1 1754.9 1779.0 1790.4 1801.9 65912.7 67060.3 68660.3 69003.3 69554.7 9497.9 9515.2 9875.3 10096.3 10207.7 13524.6 13598.5 13701.9 13720.1 13721.9 7016.8 7022.2 7058.4 7131.8 7243.2 6270.7 6316.2 6351.7 6377.9 6605.1 6072.3 6224.3 6319.4 6366.5 6396.8 1582.8 1645.4 1767.5 1788.0 1788.8 868.2 885.2 920.9 944.3 1011.7 16832.0 16973.4 17714.7 18319.0 19187.0 835.4 848.6 883.9 894.4 910.8 9684.9 9873.3 9944.3 10010.5 10046.5 403072.0 404441.0 420738.0 433535.0 434724.0 49471.8 79557.6 83156.0 83620.6 85243.1 927.1 941.9 953.6 954.1 965.0 15460.9 15937.3 16054.7 16163.8 16425.4 30255.5 32527.3 37760.6 38905.6 39801.8 52931.7 53801.9 54266.2 54830.0 55170.2 7476.0 7547.2 7693.1 7717.7 7785.3 10706.4 12214.8 12363.7 12396.1 12665.6 9710.5 10422.8 10455.3 10600.1 10648.4 10140.6 10445.5 10477.2 10684.2 10685.3 10377.1 10449.3 10532.3 10577.7 10813.4 6504.5 6983.5 7681.5 7780.8 7891.2 9611.8 9989.0 10324.9 10768.8 10865.2 01:51:32 INFO - PROCESS | 8699 | 01:51:32 INFO - PROCESS | 8699 | [#3] mootools.html Cycles:180 Average:5067.61 Median:4847.75 stddev:2836.64 (58.5%) stddev-sans-first:2830.91 01:51:32 INFO - PROCESS | 8699 | Values: 1359.3 1401.1 1454.1 1654.2 1664.5 6824.1 7395.3 7521.5 7819.5 7962.3 7588.0 7753.9 7847.4 7859.8 7898.1 2187.9 2228.0 2228.5 2228.6 2239.8 2158.4 2179.1 2243.9 2245.1 2251.2 2227.2 2233.3 2235.5 2238.1 2269.9 2168.2 2175.8 2181.3 2192.9 2208.4 2097.1 2131.9 2151.2 2152.1 2162.8 7796.3 7824.4 7839.3 7891.1 7930.4 4452.0 4515.3 4558.7 4563.8 4587.2 2851.2 2865.8 2904.2 2962.6 2989.9 944.6 951.3 966.7 995.4 995.4 10186.7 10249.7 10262.5 10310.1 10402.2 3956.5 4082.2 4182.4 4191.2 4212.9 8850.5 8855.5 8863.1 8924.5 9005.9 4546.1 4565.8 4574.7 4587.8 4593.9 3661.7 3984.6 4101.2 4169.1 4175.9 3627.3 3639.1 3718.2 3731.2 3762.3 1160.4 1177.4 1180.3 1181.1 1183.0 808.3 823.8 839.6 863.1 873.8 4839.2 4856.2 4958.5 5012.1 5114.9 392.8 394.4 398.7 401.0 401.1 3451.5 3485.6 3498.0 3537.3 3577.5 8852.6 9208.0 9260.2 9508.0 9518.1 9493.3 9518.8 9523.7 9523.9 9530.5 6966.1 7122.0 7122.8 7148.6 7167.5 5239.4 5383.2 5424.2 5539.2 5602.3 8915.2 8977.3 8999.7 9003.2 9024.1 8926.6 8962.8 8974.2 8988.3 8996.2 6147.8 6595.2 6769.6 6838.0 6869.3 7503.7 7507.4 7521.3 7540.0 7562.8 6692.1 6928.2 6945.9 6964.3 6979.0 6501.5 6503.3 6531.1 6546.0 6695.5 5853.2 5915.1 5917.1 5941.0 5970.5 4365.9 4380.8 4402.1 4487.0 4493.1 4486.4 4556.4 4660.7 4683.2 4705.8 01:51:32 INFO - PROCESS | 8699 | 01:51:32 INFO - PROCESS | 8699 | [#4] prototype.html Cycles:180 Average:4303.47 Median:4627.43 stddev:1248.06 (27.0%) stddev-sans-first:1214.64 01:51:32 INFO - PROCESS | 8699 | Values: 288.7 289.8 293.1 301.6 301.8 4950.7 5033.7 5101.7 5129.4 5155.7 5036.5 5052.4 5092.4 5093.9 5106.0 3920.6 3976.1 4039.8 4074.1 4081.0 3898.7 3953.9 3958.2 3978.2 3993.5 3954.8 3987.8 3993.4 4000.4 4013.4 3903.5 3991.5 3999.4 4002.0 4009.2 3526.0 3543.7 3545.7 3548.4 3573.3 4835.6 4966.5 4974.2 4978.2 5070.7 4566.9 4571.7 4583.8 4587.3 4614.4 5278.7 5282.4 5291.7 5300.3 5362.6 3717.9 3802.7 3850.7 3850.9 3866.6 5592.8 5641.5 5642.0 5676.2 5680.5 3909.1 3940.2 3960.9 3980.2 3981.3 3671.9 3913.5 4039.0 4041.6 4042.2 4462.9 4496.9 4502.1 4505.1 4524.7 5278.6 5320.9 5418.2 5450.3 5462.6 1242.8 1307.7 1323.3 1328.4 1332.4 882.3 884.4 901.5 901.6 910.2 4553.7 4560.7 4566.9 4582.8 4611.7 5411.2 5417.6 5511.1 5530.6 5543.2 4444.4 4617.7 4629.9 4655.7 4665.2 2601.7 2615.6 2629.4 2646.0 2671.2 4485.6 4585.8 4598.3 4613.8 4670.3 4561.9 4875.6 4927.2 4928.8 4964.1 4561.3 4573.7 4585.3 4642.5 4650.9 4777.3 4858.6 4905.7 4910.9 4917.8 4558.9 4710.3 4732.7 4739.2 4757.9 4556.2 4561.5 4585.7 4616.0 4625.0 3503.3 3526.8 3526.8 3533.0 3543.9 4834.9 4915.6 4920.6 4951.3 5325.7 5143.2 5312.6 5347.8 5356.0 5419.2 5333.4 5362.3 5369.9 5371.8 5375.6 5083.3 5301.4 5309.9 5310.2 5333.7 5387.4 5391.2 5416.8 5417.1 5436.0 5280.3 5304.5 5317.6 5329.2 5329.7 01:51:32 INFO - PROCESS | 8699 | 01:51:32 INFO - PROCESS | 8699 | [#5] yui.html Cycles:180 Average:17859.99 Median:606.04 stddev:25536.13 (4213.6%) stddev-sans-first:25575.08 01:51:32 INFO - PROCESS | 8699 | Values: 653.6 684.9 694.1 711.6 718.3 12764.6 13300.3 13741.5 13745.0 14079.2 13398.3 13567.8 13617.5 13618.4 13642.5 624.1 766.2 777.7 786.7 788.7 791.7 799.4 799.8 801.6 804.1 843.7 843.9 846.2 846.2 847.1 829.0 831.1 832.5 837.4 839.0 611.2 613.7 613.9 614.7 614.8 13965.4 14269.6 14278.6 14282.1 14345.2 14406.7 14489.6 14499.5 14541.6 14610.0 10604.7 10715.2 10747.8 10843.9 10955.9 3309.1 3342.3 3401.8 3408.3 3450.9 65049.0 65367.3 65377.7 65399.7 66261.3 10768.1 10902.8 11069.0 11095.4 11290.2 20112.2 20245.0 20352.5 20739.2 20805.3 6823.6 6902.4 6969.8 7022.4 7107.6 3699.1 3773.9 3828.4 3830.0 3839.7 2794.7 2830.5 2849.1 2870.8 2890.3 494.7 517.4 519.8 520.5 522.2 560.7 607.7 611.7 622.1 646.5 8253.2 8373.0 8501.3 8503.3 8560.4 504.5 601.0 604.4 611.8 632.5 4035.2 4068.6 4172.0 4210.2 4226.5 93065.0 93239.5 93626.5 97073.5 97376.0 83488.0 84055.0 85503.6 85940.0 86743.6 76658.6 77229.2 77315.6 78841.6 78915.0 8110.0 8125.7 8227.1 8296.7 8379.2 44888.3 45332.2 45348.3 45517.8 47040.5 57770.4 57911.0 60735.4 64253.7 65020.0 10318.2 10404.5 10406.9 10710.5 10948.7 11061.4 11288.4 11356.4 11541.2 11690.8 10625.6 10799.0 10842.7 10844.6 11065.0 9665.1 9986.4 10272.2 10323.6 10712.1 9647.1 9686.5 9941.8 10251.5 10719.6 8358.7 8550.7 8636.3 9121.8 9275.6 8750.0 8803.3 8897.9 9144.5 9163.6 01:51:32 INFO - PROCESS | 8699 | -------- Summary: end -------- 01:51:32 INFO - PROCESS | 8699 | 01:51:32 INFO - TEST-INFO | 8699: exit 0 01:51:32 INFO - TEST-OK | dromaeo_css | took 1115941ms 01:51:32 INFO - TEST-START | kraken 01:51:32 INFO - operating with platform_type : linux_ 01:51:32 INFO - Initialising browser for kraken test... 01:51:32 INFO - TEST-INFO | started process 8940 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHjB7R4/profile http://localhost:38853/getInfo.html) 01:51:37 INFO - PROCESS | 8940 | __metrics Screen width/height:1600/1200 01:51:37 INFO - PROCESS | 8940 | colorDepth:24 01:51:37 INFO - PROCESS | 8940 | Browser inner width/height: 1024/697 01:51:37 INFO - PROCESS | 8940 | __metrics 01:51:38 ERROR - PROCESS | 8940 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 01:51:39 INFO - TEST-INFO | 8940: exit 0 01:51:39 INFO - Browser initialized. 01:51:39 INFO - Running cycle 1/1 for kraken test... 01:51:39 INFO - TEST-INFO | started process 9060 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHjB7R4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:51:51 INFO - PROCESS | 9060 | RSS: Main: 170295296 01:51:51 INFO - PROCESS | 9060 | 01:51:53 INFO - PROCESS | 9060 | Cycle 1(1): loaded http://localhost:38853/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38853/tests/kraken/driver.html?testName=audio-beat-detection) 01:51:54 INFO - PROCESS | 9060 | RSS: Main: 174940160 01:51:54 INFO - PROCESS | 9060 | 01:51:57 INFO - PROCESS | 9060 | Cycle 1(1): loaded http://localhost:38853/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38853/tests/kraken/driver.html?testName=audio-dft) 01:51:58 INFO - PROCESS | 9060 | RSS: Main: 175480832 01:51:58 INFO - PROCESS | 9060 | 01:52:01 INFO - PROCESS | 9060 | Cycle 1(1): loaded http://localhost:38853/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38853/tests/kraken/driver.html?testName=audio-fft) 01:52:01 INFO - PROCESS | 9060 | RSS: Main: 169619456 01:52:01 INFO - PROCESS | 9060 | 01:52:04 INFO - PROCESS | 9060 | Cycle 1(1): loaded http://localhost:38853/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38853/tests/kraken/driver.html?testName=audio-oscillator) 01:52:04 INFO - PROCESS | 9060 | RSS: Main: 170131456 01:52:04 INFO - PROCESS | 9060 | 01:52:06 INFO - PROCESS | 9060 | Cycle 1(1): loaded http://localhost:38853/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38853/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:52:07 INFO - PROCESS | 9060 | RSS: Main: 170397696 01:52:07 INFO - PROCESS | 9060 | 01:52:10 INFO - PROCESS | 9060 | Cycle 1(1): loaded http://localhost:38853/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38853/tests/kraken/driver.html?testName=imaging-darkroom) 01:52:11 INFO - PROCESS | 9060 | RSS: Main: 170909696 01:52:11 INFO - PROCESS | 9060 | 01:52:15 INFO - PROCESS | 9060 | Cycle 1(1): loaded http://localhost:38853/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38853/tests/kraken/driver.html?testName=imaging-desaturate) 01:52:15 INFO - PROCESS | 9060 | RSS: Main: 168349696 01:52:15 INFO - PROCESS | 9060 | 01:52:18 INFO - PROCESS | 9060 | Cycle 1(1): loaded http://localhost:38853/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38853/tests/kraken/driver.html?testName=json-parse-financial) 01:52:19 INFO - PROCESS | 9060 | RSS: Main: 169836544 01:52:19 INFO - PROCESS | 9060 | 01:52:20 INFO - PROCESS | 9060 | Cycle 1(1): loaded http://localhost:38853/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38853/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:52:21 INFO - PROCESS | 9060 | RSS: Main: 170090496 01:52:21 INFO - PROCESS | 9060 | 01:52:23 INFO - PROCESS | 9060 | Cycle 1(1): loaded http://localhost:38853/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38853/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:52:24 INFO - PROCESS | 9060 | RSS: Main: 170434560 01:52:24 INFO - PROCESS | 9060 | 01:52:26 INFO - PROCESS | 9060 | Cycle 1(1): loaded http://localhost:38853/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38853/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:52:27 INFO - PROCESS | 9060 | RSS: Main: 170598400 01:52:27 INFO - PROCESS | 9060 | 01:52:29 INFO - PROCESS | 9060 | Cycle 1(1): loaded http://localhost:38853/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38853/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:52:30 INFO - PROCESS | 9060 | RSS: Main: 170536960 01:52:30 INFO - PROCESS | 9060 | 01:52:33 INFO - PROCESS | 9060 | Cycle 1(1): loaded http://localhost:38853/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38853/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:52:34 INFO - PROCESS | 9060 | RSS: Main: 170143744 01:52:34 INFO - PROCESS | 9060 | 01:52:35 INFO - PROCESS | 9060 | Cycle 1(1): loaded http://localhost:38853/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38853/tests/kraken/driver.html?testName=ai-astar) 01:52:36 INFO - PROCESS | 9060 | RSS: Main: 171208704 01:52:36 INFO - PROCESS | 9060 | 01:52:36 INFO - PROCESS | 9060 | __start_tp_report 01:52:36 INFO - PROCESS | 9060 | _x_x_mozilla_page_load 01:52:36 INFO - PROCESS | 9060 | _x_x_mozilla_page_load_details 01:52:36 INFO - PROCESS | 9060 | |i|pagename|runs| 01:52:36 INFO - PROCESS | 9060 | |0;ai-astar;108;118;111;115;118;118;119;120;118;119 01:52:36 INFO - PROCESS | 9060 | |1;audio-beat-detection;155;124;150;174;135;149;152;126;182;125 01:52:36 INFO - PROCESS | 9060 | |2;audio-dft;164;167;169;180;164;164;164;166;165;167 01:52:36 INFO - PROCESS | 9060 | |3;audio-fft;76;77;78;158;77;77;76;76;157;76 01:52:36 INFO - PROCESS | 9060 | |4;audio-oscillator;84;84;148;85;86;84;140;86;86;134 01:52:36 INFO - PROCESS | 9060 | |5;imaging-gaussian-blur;118;119;118;120;118;118;121;118;119;118 01:52:36 INFO - PROCESS | 9060 | |6;imaging-darkroom;152;152;152;151;151;151;152;150;152;148 01:52:36 INFO - PROCESS | 9060 | |7;imaging-desaturate;96;96;95;96;96;98;97;96;97;96 01:52:36 INFO - PROCESS | 9060 | |8;json-parse-financial;65;66;67;66;65;65;65;65;66;66 01:52:36 INFO - PROCESS | 9060 | |9;json-stringify-tinderbox;65;65;65;65;65;66;67;66;66;66 01:52:36 INFO - PROCESS | 9060 | |10;stanford-crypto-aes;79;80;89;79;79;78;79;89;85;94 01:52:36 INFO - PROCESS | 9060 | |11;stanford-crypto-ccm;149;128;140;141;144;137;142;136;173;145 01:52:36 INFO - PROCESS | 9060 | |12;stanford-crypto-pbkdf2;167;168;167;169;167;172;172;167;174;173 01:52:36 INFO - PROCESS | 9060 | |13;stanford-crypto-sha256-iterative;69;69;67;68;67;71;66;66;66;66 01:52:36 INFO - PROCESS | 9060 | __end_tp_report 01:52:36 INFO - PROCESS | 9060 | __start_cc_report 01:52:36 INFO - PROCESS | 9060 | _x_x_mozilla_cycle_collect,984 01:52:36 INFO - PROCESS | 9060 | __end_cc_report 01:52:36 INFO - PROCESS | 9060 | __startTimestamp1467363156058__endTimestamp 01:52:36 INFO - PROCESS | 9060 | 01:52:36 INFO - PROCESS | 9060 | ------- Summary: start ------- 01:52:36 INFO - PROCESS | 9060 | Number of tests: 14 01:52:36 INFO - PROCESS | 9060 | 01:52:36 INFO - PROCESS | 9060 | [#0] ai-astar Cycles:10 Average:116.40 Median:118.00 stddev:3.92 (3.3%) stddev-sans-first:2.74 01:52:36 INFO - PROCESS | 9060 | Values: 108.0 118.0 111.0 115.0 118.0 118.0 119.0 120.0 118.0 119.0 01:52:36 INFO - PROCESS | 9060 | 01:52:36 INFO - PROCESS | 9060 | [#1] audio-beat-detection Cycles:10 Average:147.20 Median:151.00 stddev:20.15 (13.3%) stddev-sans-first:21.17 01:52:36 INFO - PROCESS | 9060 | Values: 155.0 124.0 150.0 174.0 135.0 149.0 152.0 126.0 182.0 125.0 01:52:36 INFO - PROCESS | 9060 | 01:52:36 INFO - PROCESS | 9060 | [#2] audio-dft Cycles:10 Average:167.00 Median:166.50 stddev:4.88 (2.9%) stddev-sans-first:5.05 01:52:36 INFO - PROCESS | 9060 | Values: 164.0 167.0 169.0 180.0 164.0 164.0 164.0 166.0 165.0 167.0 01:52:36 INFO - PROCESS | 9060 | 01:52:36 INFO - PROCESS | 9060 | [#3] audio-fft Cycles:10 Average:92.80 Median:76.50 stddev:34.11 (44.6%) stddev-sans-first:35.63 01:52:36 INFO - PROCESS | 9060 | Values: 76.0 77.0 78.0 158.0 77.0 77.0 76.0 76.0 157.0 76.0 01:52:36 INFO - PROCESS | 9060 | 01:52:36 INFO - PROCESS | 9060 | [#4] audio-oscillator Cycles:10 Average:101.70 Median:84.50 stddev:27.10 (32.1%) stddev-sans-first:27.98 01:52:36 INFO - PROCESS | 9060 | Values: 84.0 84.0 148.0 85.0 86.0 84.0 140.0 86.0 86.0 134.0 01:52:36 INFO - PROCESS | 9060 | 01:52:36 INFO - PROCESS | 9060 | [#5] imaging-gaussian-blur Cycles:10 Average:118.70 Median:118.50 stddev:1.06 (0.9%) stddev-sans-first:1.09 01:52:36 INFO - PROCESS | 9060 | Values: 118.0 119.0 118.0 120.0 118.0 118.0 121.0 118.0 119.0 118.0 01:52:36 INFO - PROCESS | 9060 | 01:52:36 INFO - PROCESS | 9060 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:152.00 stddev:1.29 (0.8%) stddev-sans-first:1.32 01:52:36 INFO - PROCESS | 9060 | Values: 152.0 152.0 152.0 151.0 151.0 151.0 152.0 150.0 152.0 148.0 01:52:36 INFO - PROCESS | 9060 | 01:52:36 INFO - PROCESS | 9060 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 01:52:36 INFO - PROCESS | 9060 | Values: 96.0 96.0 95.0 96.0 96.0 98.0 97.0 96.0 97.0 96.0 01:52:36 INFO - PROCESS | 9060 | 01:52:36 INFO - PROCESS | 9060 | [#8] json-parse-financial Cycles:10 Average:65.60 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 01:52:36 INFO - PROCESS | 9060 | Values: 65.0 66.0 67.0 66.0 65.0 65.0 65.0 65.0 66.0 66.0 01:52:36 INFO - PROCESS | 9060 | 01:52:36 INFO - PROCESS | 9060 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 01:52:36 INFO - PROCESS | 9060 | Values: 65.0 65.0 65.0 65.0 65.0 66.0 67.0 66.0 66.0 66.0 01:52:36 INFO - PROCESS | 9060 | 01:52:36 INFO - PROCESS | 9060 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:82.50 stddev:5.72 (6.9%) stddev-sans-first:5.88 01:52:36 INFO - PROCESS | 9060 | Values: 79.0 80.0 89.0 79.0 79.0 78.0 79.0 89.0 85.0 94.0 01:52:36 INFO - PROCESS | 9060 | 01:52:36 INFO - PROCESS | 9060 | [#11] stanford-crypto-ccm Cycles:10 Average:143.50 Median:143.00 stddev:11.84 (8.3%) stddev-sans-first:12.39 01:52:36 INFO - PROCESS | 9060 | Values: 149.0 128.0 140.0 141.0 144.0 137.0 142.0 136.0 173.0 145.0 01:52:36 INFO - PROCESS | 9060 | 01:52:36 INFO - PROCESS | 9060 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.60 Median:170.50 stddev:2.84 (1.7%) stddev-sans-first:2.85 01:52:36 INFO - PROCESS | 9060 | Values: 167.0 168.0 167.0 169.0 167.0 172.0 172.0 167.0 174.0 173.0 01:52:36 INFO - PROCESS | 9060 | 01:52:36 INFO - PROCESS | 9060 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.50 stddev:1.72 (2.5%) stddev-sans-first:1.73 01:52:36 INFO - PROCESS | 9060 | Values: 69.0 69.0 67.0 68.0 67.0 71.0 66.0 66.0 66.0 66.0 01:52:36 INFO - PROCESS | 9060 | -------- Summary: end -------- 01:52:36 INFO - PROCESS | 9060 | 01:52:37 INFO - TEST-INFO | 9060: exit 0 01:52:37 INFO - TEST-OK | kraken | took 64202ms 01:52:37 INFO - SUITE-END | took 1180s 01:52:37 INFO - Completed test suite (00:19:40) 01:52:37 INFO - javascript benchmark 01:52:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6407.301162737671, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2579.264909500793, 2641.6791604197897, 2651.655284812974, 2661.042024871046, 2673.879675414606, 4697.718136911783, 4715.198416269234, 4784.593309568682, 4789.401324834395, 4796.784144713488, 4687.992081702433, 4702.576768090871, 4713.740744259065, 4789.5210478952085, 4805.063012712522, 4320.416743739586, 4362.323839804835, 4379.321205213197, 4400.713953593022, 4439.311906654458, 4435.4233949586505, 4439.977800110995, 4458.4204053473, 4506.324051392285, 4525.773711314438, 4328.285832837578, 4363.52001279859, 4401.075774087413, 4401.075774087445, 4429.911401771947, 4405.713628614162, 4413.5365786592265, 4420.602145806861, 4439.223135951195, 4462.12988467249, 4305.160493703729, 4368.410264614268, 4394.033312671208, 4428.512863585003, 4478.216312145361, 4725.787339569728, 4811.494793046715, 4827.396575428072, 4833.564979151894, 4864.440589332236, 5072.163093089635, 5131.204663277198, 5136.126858434075, 5151.227315902607, 5189.818356357547, 5041.067402530543, 5071.087204303224, 5102.923456148161, 5134.0758663440565, 5134.922976155361, 4745.311929770164, 4766.475687674353, 4776.2119250324, 4791.520847915181, 4821.2045012573235, 5242.056429842665, 5250.3962044364625, 5254.3169387979315, 5269.420363759983, 5271.499207575351, 4990.725510096907, 5031.823886163967, 5039.546440820271, 5057.190849464142, 5073.735169712681, 4975.875603109879, 4998.225275082295, 5119.87200319995, 5135.2553879687985, 5167.0, 4992.500749925051, 5025.221090730943, 5030.4215015272985, 5075.619328550373, 5086.745662716923, 4937.629677774181, 5015.14742493777, 5029.119904016782, 5030.2957585938, 5052.974735126374, 4284.271673815459, 4295.0, 4330.220560299176, 4331.0, 4348.369486424514, 3736.962630373716, 3743.4384842273876, 3749.4375843623675, 3779.8677046303246, 3784.526934133233, 4270.359446083113, 4366.039471316305, 4375.431193944767, 4397.120575884772, 4473.888152796141, 5101.413337466239, 5128.974355128275, 5138.332016837787, 5142.820001300011, 5174.818881339135, 4315.0, 4378.912421751547, 4407.360932664746, 4420.84527041552, 4449.688521803443, 4481.551844815493, 4536.251518499476, 4568.017876156642, 4596.264597664358, 4599.08018396322, 4811.446683631427, 4814.1815891297865, 4828.686135401258, 4837.95162048375, 4861.027794441196, 5090.0, 5114.053900028507, 5121.692698437957, 5135.38375394955, 5165.483451654804, 4715.457722361835, 4763.928541071818, 4800.3279540863605, 4825.517448255287, 4829.613630909589, 5059.19052951526, 5062.240663900445, 5085.694858308513, 5128.974355128201, 5162.819301324435, 5033.949660503348, 5143.871403214949, 5148.536631703165, 5151.304573882628, 5152.5877929766275, 4813.109574728686, 4878.804847806048, 4928.556429921325, 4987.526185012418, 4995.225740010304, 4911.9754401227765, 4970.130227210151, 4976.377952755905, 4978.726170060681, 4979.626528010342, 4896.167651499325, 4905.950940490549, 4910.116179087799, 4926.3842019747535, 4952.182889823139, 4872.4153101628035, 4930.0, 4956.182229932165, 4957.950420495893, 4973.378327709036, 4855.1260773061185, 4858.878528036827, 4881.072596206709, 4885.5358740919555, 4889.3888263967], "value": 4682.378796364454, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.7270110347033, 570.426721145249, 571.6655756382517, 578.7569220927212, 596.207044630641, 26785.0, 27190.86404567977, 38666.0, 39954.60045399545, 39993.8000309998, 39528.0, 40023.0, 40033.79983100088, 40087.79956100215, 40307.19385612293, 7731.072271327449, 7864.331531819802, 7866.134725180225, 7913.28780409763, 7938.364930805551, 7747.8450430991625, 7828.452008359417, 7829.412794040441, 7831.412644051719, 7841.294283514482, 7856.096548896864, 7874.0, 7881.05427348719, 7881.881771773428, 7902.486338388015, 7761.185075567068, 7811.453198276123, 7813.726519571787, 7841.607919603997, 7850.411219158557, 7704.499207551491, 7710.57591832449, 7756.379489640815, 7756.689732410697, 7830.060392752906, 37070.0, 37167.07082322936, 37195.62804371949, 37333.25333493342, 37590.0, 3178.173674844534, 3240.5949256342956, 3276.950845737316, 3386.4243078676686, 3610.2418492116685, 28448.57327140074, 28837.855810721023, 29122.12633620995, 29158.125256242347, 29772.957946471768, 3312.9171770705684, 3317.817520036397, 3354.748393870445, 3357.8824741133944, 3374.0552645259368, 175539.0, 176514.1174294133, 176895.0, 177258.0, 177996.0, 48748.5125148751, 48879.75560122177, 48888.26667599989, 48909.532714018635, 48924.510754892, 32084.0, 32909.83545082259, 33042.66957330396, 34891.65108348884, 35139.82430087833, 13959.371828267753, 14027.088239264414, 14122.788158177636, 14179.14925104497, 14201.502947396792, 10511.632092876713, 10681.89318106809, 10697.304675196086, 10742.677719668422, 10789.892101079045, 17665.911670441565, 17672.55818604545, 17794.288228470716, 17959.910200449176, 17988.0, 6854.828629284208, 6876.484263680144, 6899.379055884994, 6945.479089068239, 7041.859162816715, 837.4054421360902, 908.1936815240937, 1039.9844002339971, 1043.8538604595362, 1050.1546255264432, 27478.862605686845, 27900.0, 28027.439451210863, 28101.43797124087, 28636.42727145487, 965.1624224779127, 973.9707808765748, 1009.7980403919246, 1025.620520407454, 1043.8121138195197, 14506.202158881151, 14934.775978360334, 15035.624109397353, 15048.548543543493, 15061.748004606177, 394532.0, 397719.0, 399961.0, 400666.0, 400679.0, 31637.52543711846, 31656.525152122736, 31790.2052448686, 31798.0, 31812.363752724817, 1153.3656488931053, 1183.1540448579308, 1185.4428418643051, 1200.4717924113363, 1201.813718873576, 26477.602835957863, 27675.86162069177, 27841.44317113687, 27870.3032424191, 27878.16365509038, 41293.0, 41413.0, 41773.37339939843, 41786.58213417949, 41851.651867851106, 322498.0, 322729.0, 323290.0, 323307.0, 325600.0, 24642.630360544248, 24646.63030054515, 24828.875855620605, 25071.749282506942, 25333.87333063323, 40968.59031409767, 41414.1717165661, 41582.58417415787, 42094.0, 42404.363934540386, 34580.308393832485, 35834.82082589675, 35893.0, 36500.26999460049, 36743.0, 35221.47167792434, 35539.28921421505, 35768.463473047406, 36255.0, 36331.63668363282, 34959.65040349564, 35067.64932350644, 35977.64022359743, 36168.0, 38875.80562097171, 29993.55009674813, 32391.51412728764, 32709.836450817595, 32904.0, 33147.33705325928, 24959.75040249647, 25244.368890777143, 25244.465774791912, 25666.486670266862, 25872.482550349265], "value": 16831.680319867148, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.6380124173962, 362.09656906019484, 363.2535140286711, 371.70263788968816, 381.8243607940347, 16134.273957671903, 17223.22495487703, 18170.091495425208, 18172.09139543024, 18213.18040688169, 16438.260278287475, 16541.255643496042, 17595.032273224966, 17647.20587573559, 17773.64452710945, 4977.601791856643, 5160.767765450545, 5186.636935414523, 5203.375594928614, 5210.322658054467, 3751.7936513491745, 5021.297018417425, 5616.663000219979, 5921.289445266574, 5929.851753706149, 5899.056151015839, 5902.2622172228475, 5916.349201587822, 5976.462118409342, 5982.461578457938, 5830.125481177814, 5944.732487038051, 5972.0444728843395, 5973.432523910222, 5992.640441573498, 5065.201853342048, 5202.583793296565, 5235.528802407764, 5247.842564723026, 5259.15853463444, 21107.40986750434, 21663.891680541656, 21807.563848722937, 21811.563768724696, 22008.779912200993, 1971.2115153938396, 2011.225678113922, 2033.5119571302928, 2074.6161960037443, 2140.882251476168, 13319.933400333033, 13378.130421522666, 13411.0, 13417.32913354338, 14002.0, 1721.0878234535592, 1754.9122543872754, 1778.9528821930082, 1790.355472030068, 1801.927922883083, 65912.71567348107, 67060.3293967059, 68660.31339686639, 69003.3099669002, 69554.65222673854, 9497.90502094984, 9515.191208747334, 9875.259355548218, 10096.34373765703, 10207.7448063799, 13524.647535246397, 13598.524051658342, 13701.931490342484, 13720.108192967426, 13721.862781372258, 7016.824579385454, 7022.192447868459, 7058.400035996895, 7131.750388736369, 7243.203247642755, 6270.655113968775, 6316.178896743486, 6351.745930162834, 6377.936220637827, 6605.141331626858, 6072.271327440647, 6224.253089629274, 6319.399657032666, 6366.522510811615, 6396.808095757135, 1582.7784110224577, 1645.3747575921072, 1767.469759072273, 1787.9553011174564, 1788.7764029496313, 868.1839071272983, 885.2431171348533, 920.8756817829641, 944.282345417474, 1011.7318910488726, 16832.0, 16973.405930792364, 17714.734278985827, 18319.0, 19187.040647967548, 835.4235577451539, 848.5926755157559, 883.88067610873, 894.3739382432324, 910.822389634015, 9684.903150968541, 9873.308868379288, 9944.303898727165, 10010.54952527138, 10046.547905344278, 403072.0, 404441.0, 420738.0, 433535.0, 434724.0, 49471.75264123656, 79557.60221198857, 83156.0, 83620.58189709013, 85243.14756852352, 927.1238679447991, 941.9199368053792, 953.6137864165163, 954.1365064616533, 964.9855252171224, 15460.9226953869, 15937.282822272793, 16054.67890642204, 16163.838361616234, 16425.425110121087, 30255.546166807075, 32527.349453010334, 37760.62239377571, 38905.6109438902, 39801.80099099486, 52931.73534132459, 53801.92396152133, 54266.18600720914, 54830.0, 55170.172447412515, 7476.0, 7547.245275472409, 7693.115291741297, 7717.6527056281475, 7785.299323060952, 10706.357618542912, 12214.75570488603, 12363.69090772738, 12396.132270740962, 12665.556705515262, 9710.465924374228, 10422.843657344994, 10455.268131230741, 10600.098991585493, 10648.414337211529, 10140.645077422254, 10445.529951152064, 10477.161827053666, 10684.198685098494, 10685.252032357661, 10377.11794497446, 10449.328107502763, 10532.315399499008, 10577.682669519927, 10813.351198928089, 6504.479641628753, 6983.546069505466, 7681.462297639112, 7780.805479863048, 7891.210878912063, 9611.807763844823, 9989.001099890243, 10324.948375258076, 10768.838467422838, 10865.239433239598], "value": 8496.260822778679, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1359.272789057854, 1401.1312985948714, 1454.1275234859086, 1654.1811803157439, 1664.459050808486, 6824.078749368834, 7395.334419902208, 7521.51110177838, 7819.530828150308, 7962.283394494501, 7587.962060189705, 7753.92246077539, 7847.411444141684, 7859.764207073797, 7898.091719452264, 2187.912483500662, 2228.0, 2228.4651683595903, 2228.5988522066023, 2239.8096161826265, 2158.3740715192575, 2179.063002908749, 2243.8541494802785, 2245.079517397867, 2251.1783199132365, 2227.24273746926, 2233.296511598849, 2235.485838257202, 2238.1271304191378, 2269.863808171515, 2168.1977668262766, 2175.7824217578273, 2181.334692918659, 2192.8684278943233, 2208.381653137124, 2097.0877668214375, 2131.8507704460694, 2151.1610471915965, 2152.1283880028614, 2162.76209616942, 7796.298333149987, 7824.4131690122895, 7839.25527074927, 7891.131975482693, 7930.405219608552, 4452.0205554777895, 4515.345274935116, 4558.749268790215, 4563.794629241659, 4587.24310488769, 2851.187411587708, 2865.8423786691724, 2904.1868276882506, 2962.5852380666724, 2989.880404783806, 944.5702205496483, 951.3198063384713, 966.6906589891238, 995.3629677006721, 995.3729150635126, 10186.745331366701, 10249.743756406075, 10262.486875656188, 10310.07209351162, 10402.167826573856, 3956.5054368203973, 4082.2447847148374, 4182.435371224907, 4191.161767646483, 4212.873613791591, 8850.468971861708, 8855.512946787989, 8863.113688631085, 8924.464532128093, 9005.864912026325, 4546.0680560485025, 4565.817367305271, 4574.725516468956, 4587.77061146948, 4593.885152871205, 3661.7436779425716, 3984.621460961204, 4101.2207680540605, 4169.061961058737, 4175.853845115406, 3627.328944145289, 3639.090227443139, 3718.1819999600584, 3731.2164445466215, 3762.3227818992295, 1160.4255893332854, 1177.3995262416058, 1180.2505409065304, 1181.0846593889632, 1183.0, 808.3210103513077, 823.7775800533942, 839.5676226743232, 863.0808189278398, 873.8077622922947, 4839.249916262985, 4856.247281671346, 4958.504149585085, 5012.072766538129, 5114.897702045938, 392.770229415795, 394.4083874188717, 398.6671129606753, 401.0295085892148, 401.06151605243286, 3451.4650229214512, 3485.5991560970815, 3498.0205542448157, 3537.2925414917117, 3577.4633804929467, 8852.557372131369, 9207.953960230156, 9260.21288190498, 9507.952460237793, 9518.095780900803, 9493.288003399774, 9518.809623807623, 9523.666671666459, 9523.857142142873, 9530.52347382628, 6966.094407726963, 7121.964390178119, 7122.821929451701, 7148.642567871586, 7167.534110282815, 5239.44985776488, 5383.192521121863, 5424.159255315432, 5539.196816461671, 5602.327720673546, 8915.197632213132, 8977.28181745472, 8999.685011024845, 9003.234725048444, 9024.052474490347, 8926.598303076247, 8962.775930601787, 8974.19232269099, 8988.32587555949, 8996.235319997873, 6147.815565533041, 6595.208574971034, 6769.627670478171, 6837.965810170917, 6869.278725733726, 7503.662335195038, 7507.399408047452, 7521.323080922743, 7539.962300188683, 7562.848743025219, 6692.130023096966, 6928.16861976566, 6945.895811562932, 6964.338387853146, 6979.0, 6501.544891857525, 6503.349665033459, 6531.11829902976, 6545.985372267306, 6695.4978376620975, 5853.180554722428, 5915.142304365929, 5917.082852157922, 5941.0, 5970.492508136857, 4365.869023929287, 4380.7590582517, 4402.141582391403, 4486.955130448654, 4493.101379724134, 4486.416765820422, 4556.430446194226, 4660.6970546914345, 4683.1804434223195, 4705.76471176433], "value": 4028.036765131994, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.72138386457067, 289.83334582615004, 293.0724257724303, 301.55821721178467, 301.78120862374766, 4950.737561921714, 5033.672811267265, 5101.668391554546, 5129.435762066169, 5155.736844473105, 5036.471170527097, 5052.368453943257, 5092.363454568179, 5093.9235911461265, 5106.0, 3920.568992317812, 3976.1252524444576, 4039.7576145431367, 4074.144429669758, 4081.0, 3898.688104951597, 3953.881383558498, 3958.150131905024, 3978.1844721831953, 3993.4608827808165, 3954.8418063277577, 3987.7806720630356, 3993.4009898515164, 4000.419939108842, 4013.351188215778, 3903.4925459690344, 3991.521017477892, 3999.440078389028, 4002.0, 4009.218202450523, 3525.964740352589, 3543.698785603227, 3545.7340699447645, 3548.361294966905, 3573.338932297507, 4835.613150947951, 4966.50334966504, 4974.204127339644, 4978.178600530908, 5070.746462676888, 4566.862994110182, 4571.657125715585, 4583.839565615188, 4587.288970209623, 4614.3770590970125, 5278.683279003272, 5282.418933917266, 5291.735413229361, 5300.310959575269, 5362.605722512175, 3717.8698745543775, 3802.6577608015136, 3850.6726928211137, 3850.942235866464, 3866.574676785551, 5592.7762889484375, 5641.464060914206, 5642.040853054949, 5676.1769543416385, 5680.488756011938, 3909.100906791454, 3940.231654827281, 3960.9107495438407, 3980.1840622672285, 3981.2880461401296, 3671.9082022949106, 3913.471681323042, 4038.9596104038583, 4041.6160464755803, 4042.1915616876154, 4462.888427789331, 4496.887577810516, 4502.054568540578, 4505.1440226357545, 4524.6832721709825, 5278.630495865329, 5320.893582128336, 5418.187271909166, 5450.264214331094, 5462.644928079662, 1242.782513060211, 1307.7319149574314, 1323.2655875988726, 1328.408858058155, 1332.3871019331023, 882.302980645283, 884.429542944797, 901.4906577783662, 901.5537309032071, 910.2081189365294, 4553.681242313006, 4560.657950653715, 4566.862994110182, 4582.77086145698, 4611.723296602215, 5411.188321751769, 5417.59368047398, 5511.090670039479, 5530.640508366943, 5543.1685247213245, 4444.422225110779, 4617.699849509839, 4629.8842528936375, 4655.74393408359, 4665.160271151158, 2601.687797464316, 2615.620734993415, 2629.4346715456268, 2645.9867700661375, 2671.170248379866, 4485.59629633328, 4585.770711464414, 4598.3102534620075, 4613.76931153441, 4670.252759558454, 4561.901525298334, 4875.561709295766, 4927.236278376858, 4928.841722195281, 4964.081644895634, 4561.338605902192, 4573.725576465423, 4585.335126406652, 4642.512536183652, 4650.906981860277, 4777.307290442797, 4858.562729354375, 4905.730184839726, 4910.86377425821, 4917.754112294299, 4558.908821823611, 4710.29345598163, 4732.692374995614, 4739.241721324572, 4757.928631070606, 4556.2254416748565, 4561.543845615412, 4585.73006361853, 4615.953840461552, 4624.976875115737, 3503.3374635276864, 3526.800887698195, 3526.8236588171003, 3533.0, 3543.911402214965, 4834.927476087932, 4915.606751459946, 4920.630952678492, 4951.257311403318, 5325.733713314241, 5143.177091665316, 5312.574994000548, 5347.807398966405, 5355.973220133875, 5419.241306217212, 5333.359996800409, 5362.276092727432, 5369.946300537101, 5371.811986580451, 5375.623706340519, 5083.288339632529, 5301.416844147064, 5309.946900530946, 5310.176922577007, 5333.73331333424, 5387.434319396407, 5391.247844450648, 5416.783328666967, 5417.079096553674, 5436.0, 5280.339957505312, 5304.496072873071, 5317.627766056339, 5329.200619907045, 5329.7068661224], "value": 3903.206305802315, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [653.5817077070676, 684.866451042047, 694.1288682703207, 711.5979471598547, 718.3463048625752, 12764.553240636567, 13300.268485233308, 13741.519046833362, 13745.03784735069, 14079.225642589654, 13398.330083495835, 13567.796483052762, 13617.523386681469, 13618.387172577233, 13642.522511712092, 624.0545573456218, 766.1763604125573, 777.657830554557, 786.7207141464784, 788.6529926832204, 791.7387262203488, 799.4044436894521, 799.8360336131108, 801.5951944268137, 804.0512195609178, 843.6541018182546, 843.9029511606152, 846.1792061700141, 846.2468403121227, 847.0597636623343, 829.0134739659785, 831.1273163178638, 832.4547421438967, 837.401258100458, 839.0267289943666, 611.1871211288975, 613.745295702283, 613.8741557980603, 614.7110857896781, 614.7940439952621, 13965.371558279901, 14269.64325891861, 14278.571642850731, 14282.071665341824, 14345.211013394259, 14406.71186576273, 14489.565313040626, 14499.492517761828, 14541.636459088502, 14610.0, 10604.68185954415, 10715.196360272932, 10747.78504429907, 10843.945780271048, 10955.945220273927, 3309.12308238317, 3342.29811739535, 3401.7958922464486, 3408.3183363327184, 3450.9309813803584, 65049.0, 65367.3463265366, 65377.67311163414, 65399.673001635165, 66261.33738662647, 10768.138548916068, 10902.836457453144, 11069.0, 11095.44522773858, 11290.153238507144, 20112.19551217964, 20245.0, 20352.49118772013, 20739.170433182804, 20805.27181548669, 6823.624700641512, 6902.378785909293, 6969.825754356181, 7022.367986881205, 7107.573545587281, 3699.093722038118, 3773.9245215096093, 3828.4448754930936, 3829.9808500957315, 3839.6928245740273, 2794.664640243184, 2830.462212179679, 2849.131015040391, 2870.81339712918, 2890.262982939379, 494.7452062187976, 517.3972322244618, 519.8154655097461, 520.4899198785135, 522.2271038862428, 560.6916196092133, 607.7265230646227, 611.7277811373984, 622.1165944359021, 646.4989633034436, 8253.174682531699, 8372.958135209406, 8501.277391421798, 8503.277221436123, 8560.443571167854, 504.50306448148547, 601.036888141458, 604.353341924137, 611.7886584562591, 632.4813652804748, 4035.1929614077303, 4068.5524592294823, 4172.0, 4210.179179949441, 4226.513950895686, 93065.0, 93239.53380233055, 93626.53186734022, 97073.5146324278, 97376.0, 83488.0, 84055.0, 85503.57248213718, 85940.0, 86743.56628216819, 76658.6167069161, 77229.22770772333, 77315.61342193253, 78841.60579197182, 78915.0, 8109.959450202711, 8125.67497300125, 8227.13615070409, 8296.709615163682, 8379.245867871921, 44888.32667509925, 45332.219470715936, 45348.31977520274, 45517.77241113773, 47040.529594703614, 57770.4222957765, 57911.0, 60735.39264607297, 64253.67873160604, 65020.0, 10318.226133040202, 10404.479776011018, 10406.907274736044, 10710.464476776286, 10948.671539853816, 11061.446927653746, 11288.379139147097, 11356.375399353115, 11541.16748913491, 11690.824637630272, 10625.574977001143, 10799.0, 10842.674719758104, 10844.620438284623, 11065.0, 9665.130138287588, 9986.35088719231, 10272.178225741773, 10323.587056517956, 10712.143028557852, 9647.1317581418, 9686.51567421612, 9941.751456213653, 10251.48742562854, 10719.571217151226, 8358.707445239388, 8550.674645429968, 8636.265917397091, 9121.817563648823, 9275.582598782936, 8749.956250218707, 8803.33974951894, 8897.866532002156, 9144.497052662167, 9163.633454661738], "value": 6571.520998425513, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1586.0999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 118.0, 111.0, 115.0, 118.0, 118.0, 119.0, 120.0, 118.0, 119.0], "value": 116.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 124.0, 150.0, 174.0, 135.0, 149.0, 152.0, 126.0, 182.0, 125.0], "value": 147.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 167.0, 169.0, 180.0, 164.0, 164.0, 164.0, 166.0, 165.0, 167.0], "value": 167.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 78.0, 158.0, 77.0, 77.0, 76.0, 76.0, 157.0, 76.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 148.0, 85.0, 86.0, 84.0, 140.0, 86.0, 86.0, 134.0], "value": 101.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 118.0, 120.0, 118.0, 118.0, 121.0, 118.0, 119.0, 118.0], "value": 118.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 152.0, 152.0, 151.0, 151.0, 151.0, 152.0, 150.0, 152.0, 148.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 98.0, 97.0, 96.0, 97.0, 96.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 67.0, 66.0, 65.0, 65.0, 65.0, 65.0, 66.0, 66.0], "value": 65.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 66.0, 67.0, 66.0, 66.0, 66.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 89.0, 79.0, 79.0, 78.0, 79.0, 89.0, 85.0, 94.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 128.0, 140.0, 141.0, 144.0, 137.0, 142.0, 136.0, 173.0, 145.0], "value": 143.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 168.0, 167.0, 169.0, 167.0, 172.0, 172.0, 167.0, 174.0, 173.0], "value": 169.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 67.0, 68.0, 67.0, 71.0, 66.0, 66.0, 66.0, 66.0], "value": 67.5, "unit": "score"}]}]} 01:52:37 INFO - Return code: 0 01:52:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:52:37 ERROR - # TBPL SUCCESS # 01:52:37 INFO - Running post-action listener: _resource_record_post_action 01:52:37 INFO - ##### 01:52:37 INFO - ##### Finished run-tests step (success) 01:52:37 INFO - ##### 01:52:37 INFO - Running post-run listener: _resource_record_post_run 01:52:37 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 558432256; Read time: 12; Write time: 522220 01:52:37 INFO - TinderboxPrint: CPU usage
13.4% 01:52:37 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 01:52:37 INFO - TinderboxPrint: I/O write bytes / time
558,432,256 / 522,220 01:52:37 INFO - TinderboxPrint: CPU idle
8,266.6 (86.5%) 01:52:37 INFO - TinderboxPrint: CPU user
1,227.9 (12.9%) 01:52:37 INFO - TinderboxPrint: Swap in / out
0 / 0 01:52:37 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 257232896; Read time: 0; Write time: 299220 01:52:37 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 300777472; Read time: 0; Write time: 222972 01:52:37 INFO - Running post-run listener: _upload_blobber_files 01:52:37 INFO - Blob upload gear active. 01:52:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:52:37 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 01:52:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:52:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:52:38 INFO - (blobuploader) - INFO - Open directory for files ... 01:52:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:52:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:52:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:52:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:52:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:52:39 INFO - (blobuploader) - INFO - Done attempting. 01:52:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:52:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:52:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:52:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:52:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:52:42 INFO - (blobuploader) - INFO - Done attempting. 01:52:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:52:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:52:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:52:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:52:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:52:43 INFO - (blobuploader) - INFO - Done attempting. 01:52:43 INFO - (blobuploader) - INFO - Iteration through files over. 01:52:43 INFO - Return code: 0 01:52:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:52:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:52:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/eb1bd9d1f4255149825816fa96dae1020ac39532dbfa0a85f220b104844c9623b5ebef95dd931f290c6f83544e733cb67927784cec41ca23c18a42d471f6fc3a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c2a69bf050d0f9f1fe45690e505350d8f420b1b0dbb2c6acb614945b26f2d02b528564eabe8ed126cb3905ffb7682ffc0e85c04041e67be2751f9870fe1da444", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/53f5b45df038b4434122494209fc4cead03f93214acc37b4fc2b65f6c78fb106d03ffb8999e19fd29fcff823a1310d3dd0551f5b61f08a2b233b49b3dbb0d99b"} 01:52:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:52:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:52:43 INFO - Contents: 01:52:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/eb1bd9d1f4255149825816fa96dae1020ac39532dbfa0a85f220b104844c9623b5ebef95dd931f290c6f83544e733cb67927784cec41ca23c18a42d471f6fc3a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c2a69bf050d0f9f1fe45690e505350d8f420b1b0dbb2c6acb614945b26f2d02b528564eabe8ed126cb3905ffb7682ffc0e85c04041e67be2751f9870fe1da444", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/53f5b45df038b4434122494209fc4cead03f93214acc37b4fc2b65f6c78fb106d03ffb8999e19fd29fcff823a1310d3dd0551f5b61f08a2b233b49b3dbb0d99b"} 01:52:43 INFO - Running post-run listener: copy_logs_to_upload_dir 01:52:43 INFO - Copying logs to upload dir... 01:52:43 INFO - mkdir: /builds/slave/test/build/upload/logs 01:52:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.622463 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-01 01:52:42.199710) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 01:52:42.202926) ========= 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=52faae308a556c440401f8e5000001e8-1467361440.663428-638311842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/eb1bd9d1f4255149825816fa96dae1020ac39532dbfa0a85f220b104844c9623b5ebef95dd931f290c6f83544e733cb67927784cec41ca23c18a42d471f6fc3a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c2a69bf050d0f9f1fe45690e505350d8f420b1b0dbb2c6acb614945b26f2d02b528564eabe8ed126cb3905ffb7682ffc0e85c04041e67be2751f9870fe1da444", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/53f5b45df038b4434122494209fc4cead03f93214acc37b4fc2b65f6c78fb106d03ffb8999e19fd29fcff823a1310d3dd0551f5b61f08a2b233b49b3dbb0d99b"} build_url:https://queue.taskcluster.net/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011512 build_url: 'https://queue.taskcluster.net/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/eb1bd9d1f4255149825816fa96dae1020ac39532dbfa0a85f220b104844c9623b5ebef95dd931f290c6f83544e733cb67927784cec41ca23c18a42d471f6fc3a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c2a69bf050d0f9f1fe45690e505350d8f420b1b0dbb2c6acb614945b26f2d02b528564eabe8ed126cb3905ffb7682ffc0e85c04041e67be2751f9870fe1da444", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/53f5b45df038b4434122494209fc4cead03f93214acc37b4fc2b65f6c78fb106d03ffb8999e19fd29fcff823a1310d3dd0551f5b61f08a2b233b49b3dbb0d99b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 01:52:42.228722) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 01:52:42.229073) ========= 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=52faae308a556c440401f8e5000001e8-1467361440.663428-638311842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 01:52:42.310596) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 01:52:42.310924) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 01:52:42.311261) ========= ========= Total master_lag: 0.15 =========