builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-029 starttime: 1470149256.98 results: success (0) buildid: 20160802073509 builduid: 2cbbb8536cad4f1abba49f47a64c8163 revision: 8248ff77be0fa18183018e081ad62c9fb050b6d6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-02 07:47:36.982806) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-02 07:47:36.983290) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-02 07:47:36.983569) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-02 07:47:36.998279) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 07:47:36.998649) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1470149256.774787-359842650 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-02 07:47:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227M=0s 2016-08-02 07:47:37 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104542 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 07:47:37.117050) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 07:47:37.117362) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1470149256.774787-359842650 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014036 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 07:47:37.166632) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 07:47:37.166987) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 8248ff77be0fa18183018e081ad62c9fb050b6d6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 8248ff77be0fa18183018e081ad62c9fb050b6d6 --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=9ee515b9ec57ce2c386832a8000001b4-1470149256.774787-359842650 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-02 07:47:37,679 truncating revision to first 12 chars 2016-08-02 07:47:37,679 Setting DEBUG logging. 2016-08-02 07:47:37,679 attempt 1/10 2016-08-02 07:47:37,679 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/8248ff77be0f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-02 07:47:38,087 unpacking tar archive at: mozilla-inbound-8248ff77be0f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.733711 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 07:47:37.914555) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-02 07:47:37.914876) ========= script_repo_revision: 8248ff77be0fa18183018e081ad62c9fb050b6d6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-02 07:47:37.915370) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-02 07:47:37.915644) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-02 07:47:37.926440) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-08-02 07:47:37.926773) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=9ee515b9ec57ce2c386832a8000001b4-1470149256.774787-359842650 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:47:38 INFO - MultiFileLogger online at 20160802 07:47:38 in /builds/slave/test 07:47:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 07:47:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:47:38 INFO - {'append_to_log': False, 07:47:38 INFO - 'base_work_dir': '/builds/slave/test', 07:47:38 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 07:47:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:47:38 INFO - 'branch': 'Mozilla-Inbound', 07:47:38 INFO - 'buildbot_json_path': 'buildprops.json', 07:47:38 INFO - 'config_files': ('talos/linux_config.py',), 07:47:38 INFO - 'default_actions': ('clobber', 07:47:38 INFO - 'read-buildbot-config', 07:47:38 INFO - 'download-and-extract', 07:47:38 INFO - 'populate-webroot', 07:47:38 INFO - 'create-virtualenv', 07:47:38 INFO - 'install', 07:47:38 INFO - 'run-tests'), 07:47:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:47:38 INFO - 'download_minidump_stackwalk': True, 07:47:38 INFO - 'download_symbols': 'ondemand', 07:47:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:47:38 INFO - 'tooltool.py': '/tools/tooltool.py', 07:47:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:47:38 INFO - '/tools/misc-python/virtualenv.py')}, 07:47:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:47:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:47:38 INFO - 'installer_path': 'installer.exe', 07:47:38 INFO - 'log_level': 'info', 07:47:38 INFO - 'log_name': 'talos', 07:47:38 INFO - 'log_to_console': True, 07:47:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:47:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:47:38 INFO - 'opt_config_files': (), 07:47:38 INFO - 'pip_index': False, 07:47:38 INFO - 'sps_profile': False, 07:47:38 INFO - 'sps_profile_interval': 0, 07:47:38 INFO - 'suite': 'dromaeojs-e10s', 07:47:38 INFO - 'system_bits': '32', 07:47:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:47:38 INFO - 'title': 'talos-linux64-ix-029', 07:47:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:47:38 INFO - 'use_talos_json': True, 07:47:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:47:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:47:38 INFO - 'work_dir': 'build'} 07:47:38 INFO - [mozharness: 2016-08-02 14:47:38.533493Z] Running clobber step. 07:47:38 INFO - Running pre-action listener: _resource_record_pre_action 07:47:38 INFO - Running main action method: clobber 07:47:38 INFO - rmtree: /builds/slave/test/build 07:47:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:47:38 INFO - Running post-action listener: _resource_record_post_action 07:47:38 INFO - [mozharness: 2016-08-02 14:47:38.992766Z] Finished clobber step (success) 07:47:38 INFO - [mozharness: 2016-08-02 14:47:38.992868Z] Running read-buildbot-config step. 07:47:38 INFO - Running pre-action listener: _resource_record_pre_action 07:47:38 INFO - Running main action method: read_buildbot_config 07:47:38 INFO - Using buildbot properties: 07:47:38 INFO - { 07:47:38 INFO - "project": "", 07:47:38 INFO - "product": "firefox", 07:47:38 INFO - "script_repo_revision": "production", 07:47:38 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 07:47:38 INFO - "repository": "", 07:47:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 07:47:38 INFO - "buildid": "20160802073509", 07:47:38 INFO - "stage_platform": "linux64-pgo", 07:47:38 INFO - "basedir": "/builds/slave/test", 07:47:38 INFO - "buildnumber": 1112, 07:47:38 INFO - "platform": "ubuntu64_hw", 07:47:38 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:47:38 INFO - "slavebuilddir": "test", 07:47:38 INFO - "branch": "mozilla-inbound", 07:47:38 INFO - "revision": "8248ff77be0fa18183018e081ad62c9fb050b6d6", 07:47:38 INFO - "slavename": "talos-linux64-ix-029", 07:47:38 INFO - "builduid": "2cbbb8536cad4f1abba49f47a64c8163", 07:47:38 INFO - "repo_path": "integration/mozilla-inbound" 07:47:38 INFO - } 07:47:38 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470137583/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 07:47:38 INFO - Found a test packages url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470137583/firefox-51.0a1.en-US.linux-x86_64.test_packages.json. 07:47:38 INFO - Running post-action listener: _resource_record_post_action 07:47:38 INFO - [mozharness: 2016-08-02 14:47:38.995262Z] Finished read-buildbot-config step (success) 07:47:38 INFO - [mozharness: 2016-08-02 14:47:38.995350Z] Running download-and-extract step. 07:47:38 INFO - Running pre-action listener: _resource_record_pre_action 07:47:38 INFO - Running main action method: download_and_extract 07:47:38 INFO - mkdir: /builds/slave/test/build/tests 07:47:38 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')]} 07:47:38 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470137583/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 07:47:38 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470137583/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 07:47:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470137583/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:47:39 INFO - Downloaded 1361 bytes. 07:47:39 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 07:47:39 INFO - Using the following test package requirements: 07:47:39 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 07:47:39 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:47:39 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:47:39 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:47:39 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:47:39 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:47:39 INFO - u'jsshell-linux-x86_64.zip'], 07:47:39 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:47:39 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:47:39 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 07:47:39 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:47:39 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:47:39 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:47:39 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:47:39 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:47:39 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:47:39 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:47:39 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:47:39 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:47: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')]} 07:47:39 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470137583/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:47:39 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470137583/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:47:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470137583/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:47:39 INFO - Downloaded 21809620 bytes. 07:47:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:47:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:47:40 INFO - Return code: 0 07:47:40 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:47:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:47:40 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470137583/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:47:40 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470137583/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:47:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470137583/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:47:41 INFO - Downloaded 21809620 bytes. 07:47:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:47:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:47:43 INFO - Return code: 0 07:47:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:47:43 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470137583/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 07:47:43 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470137583/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 07:47:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470137583/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:47:43 INFO - Downloaded 14413723 bytes. 07:47:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:47:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:47:43 INFO - Return code: 0 07:47:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:47:43 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470137583/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:47:43 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470137583/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:47:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470137583/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:47:44 INFO - Downloaded 59388271 bytes. 07:47:44 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470137583/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:47:44 INFO - mkdir: /builds/slave/test/properties 07:47:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:47:44 INFO - Writing to file /builds/slave/test/properties/build_url 07:47:44 INFO - Contents: 07:47:44 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470137583/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:47:45 INFO - Running post-action listener: _resource_record_post_action 07:47:45 INFO - Running post-action listener: set_extra_try_arguments 07:47:45 INFO - [mozharness: 2016-08-02 14:47:45.078028Z] Finished download-and-extract step (success) 07:47:45 INFO - [mozharness: 2016-08-02 14:47:45.078263Z] Running populate-webroot step. 07:47:45 INFO - Running pre-action listener: _resource_record_pre_action 07:47:45 INFO - Running main action method: populate_webroot 07:47:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:47:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:47:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:47:45 INFO - '--tppagecycles', 07:47:45 INFO - '7'], 07:47:45 INFO - 'tests': ['tsvgm']}}, 07:47:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:47:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:47:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:47:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:47:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:47:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:47:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:45 INFO - 'talos_options': ['--disable-e10s'], 07:47:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:47:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:47:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:45 INFO - 'talos_options': ['--disable-e10s'], 07:47:45 INFO - 'tests': ['damp', 'tps']}, 07:47:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:45 INFO - 'tests': ['damp', 'tps']}, 07:47:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:47:45 INFO - 'tests': ['dromaeo_dom']}, 07:47:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:47:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:47:45 INFO - 'tests': ['basic_compositor_video']}, 07:47:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:47:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:47:45 INFO - 'tests': ['a11yr', 07:47:45 INFO - 'ts_paint', 07:47:45 INFO - 'tpaint', 07:47:45 INFO - 'sessionrestore', 07:47:45 INFO - 'sessionrestore_no_auto_restore', 07:47:45 INFO - 'tabpaint']}, 07:47:45 INFO - 'other-e10s': {'tests': ['a11yr', 07:47:45 INFO - 'ts_paint', 07:47:45 INFO - 'tpaint', 07:47:45 INFO - 'sessionrestore', 07:47:45 INFO - 'sessionrestore_no_auto_restore', 07:47:45 INFO - 'tabpaint']}, 07:47:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:47:45 INFO - 'ts_paint', 07:47:45 INFO - 'tpaint', 07:47:45 INFO - 'sessionrestore', 07:47:45 INFO - 'sessionrestore_no_auto_restore', 07:47:45 INFO - 'tabpaint']}, 07:47:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:47:45 INFO - 'ts_paint', 07:47:45 INFO - 'tpaint', 07:47:45 INFO - 'sessionrestore', 07:47:45 INFO - 'sessionrestore_no_auto_restore', 07:47:45 INFO - 'tabpaint']}, 07:47:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:47:45 INFO - 'tests': ['a11yr', 07:47:45 INFO - 'ts_paint', 07:47:45 INFO - 'tpaint', 07:47:45 INFO - 'sessionrestore', 07:47:45 INFO - 'sessionrestore_no_auto_restore', 07:47:45 INFO - 'tabpaint']}, 07:47:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:47:45 INFO - 'tests': ['a11yr', 07:47:45 INFO - 'ts_paint', 07:47:45 INFO - 'tpaint', 07:47:45 INFO - 'sessionrestore', 07:47:45 INFO - 'sessionrestore_no_auto_restore', 07:47:45 INFO - 'tabpaint']}, 07:47:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:47:45 INFO - 'tests': ['tsvgx', 07:47:45 INFO - 'tsvgr_opacity', 07:47:45 INFO - 'tart', 07:47:45 INFO - 'tscrollx', 07:47:45 INFO - 'cart']}, 07:47:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:47:45 INFO - 'tsvgr_opacity', 07:47:45 INFO - 'tart', 07:47:45 INFO - 'tscrollx', 07:47:45 INFO - 'cart']}, 07:47:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:45 INFO - 'talos_options': ['--disable-e10s'], 07:47:45 INFO - 'tests': ['tp5o']}, 07:47:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:45 INFO - 'tests': ['tp5o']}, 07:47:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:45 INFO - 'talos_options': ['--disable-e10s', 07:47:45 INFO - '--xperf_path', 07:47:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:47:45 INFO - 'tests': ['tp5n']}, 07:47:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:45 INFO - 'talos_options': ['--xperf_path', 07:47:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:47:45 INFO - 'tests': ['tp5n']}}, 07:47:45 INFO - 'talos.zip': {'path': '', 07:47:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:47:45 INFO - Running post-action listener: _resource_record_post_action 07:47:45 INFO - [mozharness: 2016-08-02 14:47:45.096100Z] Finished populate-webroot step (success) 07:47:45 INFO - [mozharness: 2016-08-02 14:47:45.096190Z] Running create-virtualenv step. 07:47:45 INFO - Running pre-action listener: _resource_record_pre_action 07:47:45 INFO - Running main action method: create_virtualenv 07:47:45 INFO - Creating virtualenv /builds/slave/test/build/venv 07:47:45 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 07:47:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:47:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:47:45 INFO - Using real prefix '/usr' 07:47:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:47:45 INFO - Installing distribute.............................................................................................................................................................................................done. 07:47:47 INFO - Installing pip.................done. 07:47:47 INFO - Return code: 0 07:47:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:47:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:47:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:47:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1048030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1277400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1306570>, '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 0x1307470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1307900>, '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': '9ee515b9ec57ce2c386832a8000001b4-1470149256.774787-359842650', '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 07:47:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:47:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:47:47 INFO - Using env: {'DISPLAY': ':0', 07:47:47 INFO - 'HOME': '/home/cltbld', 07:47:47 INFO - 'LANG': 'en_US.UTF-8', 07:47:47 INFO - 'LANGUAGE': 'en_US:en', 07:47:47 INFO - 'LOGNAME': 'cltbld', 07:47:47 INFO - 'MAIL': '/var/mail/cltbld', 07:47:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:47 INFO - 'MOZ_NO_REMOTE': '1', 07:47:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:47 INFO - 'NO_EM_RESTART': '1', 07:47:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:47 INFO - 'PWD': '/builds/slave/test', 07:47:47 INFO - 'SHELL': '/bin/bash', 07:47:47 INFO - 'SHLVL': '1', 07:47:47 INFO - 'TERM': 'linux', 07:47:47 INFO - 'TMOUT': '86400', 07:47:47 INFO - 'USER': 'cltbld', 07:47:47 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1470149256.774787-359842650', 07:47:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:47 INFO - '_': '/tools/buildbot/bin/python'} 07:47:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:47 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 07:47:47 INFO - Cleaning up... 07:47:48 INFO - Return code: 0 07:47:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:47:48 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')]} 07:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:48 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')]} 07:47:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:48 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 0x1048030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1277400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1306570>, '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 0x1307470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1307900>, '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': '9ee515b9ec57ce2c386832a8000001b4-1470149256.774787-359842650', '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 07:47:48 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 07:47:48 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 07:47:48 INFO - Using env: {'DISPLAY': ':0', 07:47:48 INFO - 'HOME': '/home/cltbld', 07:47:48 INFO - 'LANG': 'en_US.UTF-8', 07:47:48 INFO - 'LANGUAGE': 'en_US:en', 07:47:48 INFO - 'LOGNAME': 'cltbld', 07:47:48 INFO - 'MAIL': '/var/mail/cltbld', 07:47:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:48 INFO - 'MOZ_NO_REMOTE': '1', 07:47:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:48 INFO - 'NO_EM_RESTART': '1', 07:47:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:48 INFO - 'PWD': '/builds/slave/test', 07:47:48 INFO - 'SHELL': '/bin/bash', 07:47:48 INFO - 'SHLVL': '1', 07:47:48 INFO - 'TERM': 'linux', 07:47:48 INFO - 'TMOUT': '86400', 07:47:48 INFO - 'USER': 'cltbld', 07:47:48 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1470149256.774787-359842650', 07:47:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:48 INFO - '_': '/tools/buildbot/bin/python'} 07:47:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:48 INFO - Downloading/unpacking psutil>=3.1.1 07:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:47:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:47:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:47:50 INFO - Installing collected packages: psutil 07:47:50 INFO - Running setup.py install for psutil 07:47:50 INFO - building 'psutil._psutil_linux' extension 07:47:50 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 07:47:50 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 07:47:50 INFO - building 'psutil._psutil_posix' extension 07:47:50 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 07:47:50 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 07:47:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:47:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:47:50 INFO - Successfully installed psutil 07:47:50 INFO - Cleaning up... 07:47:50 INFO - Return code: 0 07:47:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:47:50 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')]} 07:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:50 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')]} 07:47:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:50 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 0x1048030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1277400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1306570>, '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 0x1307470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1307900>, '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': '9ee515b9ec57ce2c386832a8000001b4-1470149256.774787-359842650', '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 07:47:50 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 07:47:50 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 07:47:50 INFO - Using env: {'DISPLAY': ':0', 07:47:50 INFO - 'HOME': '/home/cltbld', 07:47:50 INFO - 'LANG': 'en_US.UTF-8', 07:47:50 INFO - 'LANGUAGE': 'en_US:en', 07:47:50 INFO - 'LOGNAME': 'cltbld', 07:47:50 INFO - 'MAIL': '/var/mail/cltbld', 07:47:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:50 INFO - 'MOZ_NO_REMOTE': '1', 07:47:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:50 INFO - 'NO_EM_RESTART': '1', 07:47:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:50 INFO - 'PWD': '/builds/slave/test', 07:47:50 INFO - 'SHELL': '/bin/bash', 07:47:50 INFO - 'SHLVL': '1', 07:47:50 INFO - 'TERM': 'linux', 07:47:50 INFO - 'TMOUT': '86400', 07:47:50 INFO - 'USER': 'cltbld', 07:47:50 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1470149256.774787-359842650', 07:47:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:50 INFO - '_': '/tools/buildbot/bin/python'} 07:47:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:47:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:47:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:47:52 INFO - Installing collected packages: mozsystemmonitor 07:47:52 INFO - Running setup.py install for mozsystemmonitor 07:47:52 INFO - Successfully installed mozsystemmonitor 07:47:52 INFO - Cleaning up... 07:47:53 INFO - Return code: 0 07:47:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:47:53 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')]} 07:47:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:53 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')]} 07:47:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:53 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 0x1048030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1277400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1306570>, '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 0x1307470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1307900>, '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': '9ee515b9ec57ce2c386832a8000001b4-1470149256.774787-359842650', '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 07:47:53 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 07:47:53 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 07:47:53 INFO - Using env: {'DISPLAY': ':0', 07:47:53 INFO - 'HOME': '/home/cltbld', 07:47:53 INFO - 'LANG': 'en_US.UTF-8', 07:47:53 INFO - 'LANGUAGE': 'en_US:en', 07:47:53 INFO - 'LOGNAME': 'cltbld', 07:47:53 INFO - 'MAIL': '/var/mail/cltbld', 07:47:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:53 INFO - 'MOZ_NO_REMOTE': '1', 07:47:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:53 INFO - 'NO_EM_RESTART': '1', 07:47:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:53 INFO - 'PWD': '/builds/slave/test', 07:47:53 INFO - 'SHELL': '/bin/bash', 07:47:53 INFO - 'SHLVL': '1', 07:47:53 INFO - 'TERM': 'linux', 07:47:53 INFO - 'TMOUT': '86400', 07:47:53 INFO - 'USER': 'cltbld', 07:47:53 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1470149256.774787-359842650', 07:47:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:53 INFO - '_': '/tools/buildbot/bin/python'} 07:47:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:53 INFO - Downloading/unpacking jsonschema==2.5.1 07:47:53 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 07:47:53 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 07:47:53 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 07:47:53 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 07:47:53 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 07:47:53 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 07:47:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:47:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:47:55 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 07:47:55 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 07:47:55 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 07:47:55 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 07:47:55 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 07:47:55 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 07:47:55 INFO - Downloading functools32-3.2.3-2.tar.gz 07:47:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:47:55 INFO - warning: no files found matching '*.txt' 07:47:55 INFO - no previously-included directories found matching 'build' 07:47:55 INFO - no previously-included directories found matching 'dist' 07:47:55 INFO - no previously-included directories found matching '.git*' 07:47:55 INFO - Installing collected packages: jsonschema, functools32 07:47:55 INFO - Running setup.py install for functools32 07:47:55 INFO - warning: no files found matching '*.txt' 07:47:55 INFO - no previously-included directories found matching 'build' 07:47:55 INFO - no previously-included directories found matching 'dist' 07:47:55 INFO - no previously-included directories found matching '.git*' 07:47:55 INFO - Successfully installed jsonschema functools32 07:47:55 INFO - Cleaning up... 07:47:55 INFO - Return code: 0 07:47:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:47:55 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')]} 07:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:55 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')]} 07:47:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1048030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1277400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1306570>, '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 0x1307470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1307900>, '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': '9ee515b9ec57ce2c386832a8000001b4-1470149256.774787-359842650', '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 07:47:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:47:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:47:55 INFO - Using env: {'DISPLAY': ':0', 07:47:55 INFO - 'HOME': '/home/cltbld', 07:47:55 INFO - 'LANG': 'en_US.UTF-8', 07:47:55 INFO - 'LANGUAGE': 'en_US:en', 07:47:55 INFO - 'LOGNAME': 'cltbld', 07:47:55 INFO - 'MAIL': '/var/mail/cltbld', 07:47:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:55 INFO - 'MOZ_NO_REMOTE': '1', 07:47:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:55 INFO - 'NO_EM_RESTART': '1', 07:47:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:55 INFO - 'PWD': '/builds/slave/test', 07:47:55 INFO - 'SHELL': '/bin/bash', 07:47:55 INFO - 'SHLVL': '1', 07:47:55 INFO - 'TERM': 'linux', 07:47:55 INFO - 'TMOUT': '86400', 07:47:55 INFO - 'USER': 'cltbld', 07:47:55 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1470149256.774787-359842650', 07:47:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:55 INFO - '_': '/tools/buildbot/bin/python'} 07:47:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:47:55 INFO - Cleaning up... 07:47:55 INFO - Return code: 0 07:47:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:47:55 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')]} 07:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:55 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')]} 07:47:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:55 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 0x1048030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1277400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1306570>, '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 0x1307470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1307900>, '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': '9ee515b9ec57ce2c386832a8000001b4-1470149256.774787-359842650', '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 07:47:55 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 07:47:55 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 07:47:55 INFO - Using env: {'DISPLAY': ':0', 07:47:55 INFO - 'HOME': '/home/cltbld', 07:47:55 INFO - 'LANG': 'en_US.UTF-8', 07:47:55 INFO - 'LANGUAGE': 'en_US:en', 07:47:55 INFO - 'LOGNAME': 'cltbld', 07:47:55 INFO - 'MAIL': '/var/mail/cltbld', 07:47:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:55 INFO - 'MOZ_NO_REMOTE': '1', 07:47:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:55 INFO - 'NO_EM_RESTART': '1', 07:47:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:55 INFO - 'PWD': '/builds/slave/test', 07:47:55 INFO - 'SHELL': '/bin/bash', 07:47:55 INFO - 'SHLVL': '1', 07:47:55 INFO - 'TERM': 'linux', 07:47:55 INFO - 'TMOUT': '86400', 07:47:55 INFO - 'USER': 'cltbld', 07:47:55 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1470149256.774787-359842650', 07:47:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:55 INFO - '_': '/tools/buildbot/bin/python'} 07:47:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:56 INFO - Downloading/unpacking blobuploader==1.2.4 07:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:57 INFO - Downloading blobuploader-1.2.4.tar.gz 07:47:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:47:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:47:58 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 07:47:58 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 07:47:58 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 07:47:58 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 07:47:58 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 07:47:58 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 07:47:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:47:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:47:58 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 07:47:58 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 07:47:58 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 07:47:58 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 07:47:58 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 07:47:58 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 07:47:58 INFO - Downloading docopt-0.6.1.tar.gz 07:47:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:47:58 INFO - Installing collected packages: blobuploader, requests, docopt 07:47:58 INFO - Running setup.py install for blobuploader 07:47:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:47:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:47:58 INFO - Running setup.py install for requests 07:47:59 INFO - Running setup.py install for docopt 07:47:59 INFO - Successfully installed blobuploader requests docopt 07:47:59 INFO - Cleaning up... 07:47:59 INFO - Return code: 0 07:47:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:47:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:47:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:59 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 0x1048030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1277400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1306570>, '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 0x1307470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1307900>, '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': '9ee515b9ec57ce2c386832a8000001b4-1470149256.774787-359842650', '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 07:47:59 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 07:47:59 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 07:47:59 INFO - Using env: {'DISPLAY': ':0', 07:47:59 INFO - 'HOME': '/home/cltbld', 07:47:59 INFO - 'LANG': 'en_US.UTF-8', 07:47:59 INFO - 'LANGUAGE': 'en_US:en', 07:47:59 INFO - 'LOGNAME': 'cltbld', 07:47:59 INFO - 'MAIL': '/var/mail/cltbld', 07:47:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:59 INFO - 'MOZ_NO_REMOTE': '1', 07:47:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:59 INFO - 'NO_EM_RESTART': '1', 07:47:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:59 INFO - 'PWD': '/builds/slave/test', 07:47:59 INFO - 'SHELL': '/bin/bash', 07:47:59 INFO - 'SHLVL': '1', 07:47:59 INFO - 'TERM': 'linux', 07:47:59 INFO - 'TMOUT': '86400', 07:47:59 INFO - 'USER': 'cltbld', 07:47:59 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1470149256.774787-359842650', 07:47:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:59 INFO - '_': '/tools/buildbot/bin/python'} 07:47:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:47:59 INFO - Running setup.py (path:/tmp/pip-A9yIof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:47:59 INFO - Running setup.py (path:/tmp/pip-WwpZxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:47:59 INFO - Running setup.py (path:/tmp/pip-c8nJay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:47:59 INFO - Running setup.py (path:/tmp/pip-RsEVVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:47:59 INFO - Running setup.py (path:/tmp/pip-ZM7jVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:47:59 INFO - Running setup.py (path:/tmp/pip-wnjBca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:47:59 INFO - Running setup.py (path:/tmp/pip-LzkICi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:48:00 INFO - Running setup.py (path:/tmp/pip-X2Ip1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:48:00 INFO - Running setup.py (path:/tmp/pip-_bYp1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:48:00 INFO - Running setup.py (path:/tmp/pip-Qy68CR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:48:00 INFO - Running setup.py (path:/tmp/pip-hPkZ1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:48:00 INFO - Running setup.py (path:/tmp/pip-YxGjSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:48:00 INFO - Running setup.py (path:/tmp/pip-KHGYsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:48:00 INFO - Running setup.py (path:/tmp/pip-oQiEPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:48:00 INFO - Running setup.py (path:/tmp/pip-eRaGGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:48:00 INFO - Running setup.py (path:/tmp/pip-w8wOHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:48:00 INFO - Running setup.py (path:/tmp/pip-SrR1JP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:48:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:48:00 INFO - Running setup.py install for manifestparser 07:48:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:48:00 INFO - Running setup.py install for mozcrash 07:48:00 INFO - Running setup.py install for mozdebug 07:48:01 INFO - Running setup.py install for mozdevice 07:48:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:48:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:48:01 INFO - Running setup.py install for mozfile 07:48:01 INFO - Running setup.py install for mozhttpd 07:48:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:48:01 INFO - Running setup.py install for mozinfo 07:48:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:48:01 INFO - Running setup.py install for mozInstall 07:48:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:48:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:48:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:48:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:48:01 INFO - Running setup.py install for mozleak 07:48:01 INFO - Running setup.py install for mozlog 07:48:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:48:01 INFO - Running setup.py install for moznetwork 07:48:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:48:01 INFO - Running setup.py install for mozprocess 07:48:01 INFO - Running setup.py install for mozprofile 07:48:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:48:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:48:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:48:02 INFO - Running setup.py install for mozrunner 07:48:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:48:02 INFO - Running setup.py install for mozscreenshot 07:48:02 INFO - Running setup.py install for moztest 07:48:02 INFO - Running setup.py install for mozversion 07:48:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:48:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:48:02 INFO - Cleaning up... 07:48:02 INFO - Return code: 0 07:48:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:48:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:48:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:02 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 0x1048030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1277400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1306570>, '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 0x1307470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1307900>, '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': '9ee515b9ec57ce2c386832a8000001b4-1470149256.774787-359842650', '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 07:48:02 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 07:48:02 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 07:48:02 INFO - Using env: {'DISPLAY': ':0', 07:48:02 INFO - 'HOME': '/home/cltbld', 07:48:02 INFO - 'LANG': 'en_US.UTF-8', 07:48:02 INFO - 'LANGUAGE': 'en_US:en', 07:48:02 INFO - 'LOGNAME': 'cltbld', 07:48:02 INFO - 'MAIL': '/var/mail/cltbld', 07:48:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:02 INFO - 'MOZ_NO_REMOTE': '1', 07:48:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:48:02 INFO - 'NO_EM_RESTART': '1', 07:48:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:48:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:02 INFO - 'PWD': '/builds/slave/test', 07:48:02 INFO - 'SHELL': '/bin/bash', 07:48:02 INFO - 'SHLVL': '1', 07:48:02 INFO - 'TERM': 'linux', 07:48:02 INFO - 'TMOUT': '86400', 07:48:02 INFO - 'USER': 'cltbld', 07:48:02 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1470149256.774787-359842650', 07:48:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:02 INFO - '_': '/tools/buildbot/bin/python'} 07:48:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:48:02 INFO - Running setup.py (path:/tmp/pip-Dg1ba2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:48:02 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)) 07:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:48:02 INFO - Running setup.py (path:/tmp/pip-XUQhcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:48:02 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)) 07:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:48:02 INFO - Running setup.py (path:/tmp/pip-jN6Odc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:48:02 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)) 07:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:48:03 INFO - Running setup.py (path:/tmp/pip-cRyLhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:48:03 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)) 07:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:48:03 INFO - Running setup.py (path:/tmp/pip-8zZ2CL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:48:03 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)) 07:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:48:03 INFO - Running setup.py (path:/tmp/pip-Zxz6_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:48:03 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)) 07:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:48:03 INFO - Running setup.py (path:/tmp/pip-FwcHnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:48:03 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)) 07:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:48:03 INFO - Running setup.py (path:/tmp/pip-6a1VeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:48:03 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)) 07:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:48:03 INFO - Running setup.py (path:/tmp/pip-zyvlqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:48:03 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)) 07:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:48:03 INFO - Running setup.py (path:/tmp/pip-b2GFqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:48:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 07:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:48:03 INFO - Running setup.py (path:/tmp/pip-YU72vA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:48:03 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)) 07:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:48:03 INFO - Running setup.py (path:/tmp/pip-Utr81_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:48:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:48:03 INFO - Running setup.py (path:/tmp/pip-spcic5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:48:03 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)) 07:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:48:03 INFO - Running setup.py (path:/tmp/pip-IIufxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:48:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:48:03 INFO - Running setup.py (path:/tmp/pip-l85634-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:48:03 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)) 07:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:48:03 INFO - Running setup.py (path:/tmp/pip-cWsn_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:48:03 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)) 07:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:48:03 INFO - Running setup.py (path:/tmp/pip-EA0RoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:48:04 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)) 07:48:04 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)) 07:48:04 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)) 07:48:04 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)) 07:48:04 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)) 07:48:04 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)) 07:48:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:48:04 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 07:48:04 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 07:48:04 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 07:48:04 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 07:48:04 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 07:48:04 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 07:48:05 INFO - Downloading blessings-1.6.tar.gz 07:48:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:48:06 INFO - Installing collected packages: blessings 07:48:06 INFO - Running setup.py install for blessings 07:48:06 INFO - Successfully installed blessings 07:48:06 INFO - Cleaning up... 07:48:06 INFO - Return code: 0 07:48:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:48:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:48:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:48:06 INFO - Reading from file tmpfile_stdout 07:48:06 INFO - Current package versions: 07:48:06 INFO - argparse == 1.2.1 07:48:06 INFO - blessings == 1.6 07:48:06 INFO - blobuploader == 1.2.4 07:48:06 INFO - docopt == 0.6.1 07:48:06 INFO - functools32 == 3.2.3-2 07:48:06 INFO - jsonschema == 2.5.1 07:48:06 INFO - manifestparser == 1.1 07:48:06 INFO - mozInstall == 1.12 07:48:06 INFO - mozcrash == 0.17 07:48:06 INFO - mozdebug == 0.1 07:48:06 INFO - mozdevice == 0.48 07:48:06 INFO - mozfile == 1.2 07:48:06 INFO - mozhttpd == 0.7 07:48:06 INFO - mozinfo == 0.9 07:48:06 INFO - mozleak == 0.1 07:48:06 INFO - mozlog == 3.3 07:48:06 INFO - moznetwork == 0.27 07:48:06 INFO - mozprocess == 0.23 07:48:06 INFO - mozprofile == 0.28 07:48:06 INFO - mozrunner == 6.12 07:48:06 INFO - mozscreenshot == 0.1 07:48:06 INFO - mozsystemmonitor == 0.3 07:48:06 INFO - moztest == 0.7 07:48:06 INFO - mozversion == 1.4 07:48:06 INFO - psutil == 3.1.1 07:48:06 INFO - requests == 1.2.3 07:48:06 INFO - wsgiref == 0.1.2 07:48:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:48:06 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')]} 07:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:06 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')]} 07:48:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:06 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 0x1048030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1277400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1306570>, '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 0x1307470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1307900>, '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': '9ee515b9ec57ce2c386832a8000001b4-1470149256.774787-359842650', '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 07:48:06 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 07:48:06 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 07:48:06 INFO - Using env: {'DISPLAY': ':0', 07:48:06 INFO - 'HOME': '/home/cltbld', 07:48:06 INFO - 'LANG': 'en_US.UTF-8', 07:48:06 INFO - 'LANGUAGE': 'en_US:en', 07:48:06 INFO - 'LOGNAME': 'cltbld', 07:48:06 INFO - 'MAIL': '/var/mail/cltbld', 07:48:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:06 INFO - 'MOZ_NO_REMOTE': '1', 07:48:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:48:06 INFO - 'NO_EM_RESTART': '1', 07:48:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:48:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:06 INFO - 'PWD': '/builds/slave/test', 07:48:06 INFO - 'SHELL': '/bin/bash', 07:48:06 INFO - 'SHLVL': '1', 07:48:06 INFO - 'TERM': 'linux', 07:48:06 INFO - 'TMOUT': '86400', 07:48:06 INFO - 'USER': 'cltbld', 07:48:06 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1470149256.774787-359842650', 07:48:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:06 INFO - '_': '/tools/buildbot/bin/python'} 07:48:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:06 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)) 07:48:06 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)) 07:48:06 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)) 07:48:06 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)) 07:48:06 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)) 07:48:06 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)) 07:48:06 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)) 07:48:06 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)) 07:48:06 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)) 07:48:06 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)) 07:48:06 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)) 07:48:06 INFO - Cleaning up... 07:48:06 INFO - Return code: 0 07:48:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:48:06 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')]} 07:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:06 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')]} 07:48:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:06 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 0x1048030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1277400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1306570>, '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 0x1307470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1307900>, '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': '9ee515b9ec57ce2c386832a8000001b4-1470149256.774787-359842650', '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 07:48:06 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 07:48:06 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 07:48:06 INFO - Using env: {'DISPLAY': ':0', 07:48:06 INFO - 'HOME': '/home/cltbld', 07:48:06 INFO - 'LANG': 'en_US.UTF-8', 07:48:06 INFO - 'LANGUAGE': 'en_US:en', 07:48:06 INFO - 'LOGNAME': 'cltbld', 07:48:06 INFO - 'MAIL': '/var/mail/cltbld', 07:48:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:06 INFO - 'MOZ_NO_REMOTE': '1', 07:48:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:48:06 INFO - 'NO_EM_RESTART': '1', 07:48:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:48:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:06 INFO - 'PWD': '/builds/slave/test', 07:48:06 INFO - 'SHELL': '/bin/bash', 07:48:06 INFO - 'SHLVL': '1', 07:48:06 INFO - 'TERM': 'linux', 07:48:06 INFO - 'TMOUT': '86400', 07:48:06 INFO - 'USER': 'cltbld', 07:48:06 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1470149256.774787-359842650', 07:48:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:06 INFO - '_': '/tools/buildbot/bin/python'} 07:48:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:48:06 INFO - Cleaning up... 07:48:07 INFO - Return code: 0 07:48:07 INFO - Running post-action listener: _resource_record_post_action 07:48:07 INFO - Running post-action listener: _start_resource_monitoring 07:48:07 INFO - Starting resource monitoring. 07:48:07 INFO - [mozharness: 2016-08-02 14:48:07.035453Z] Finished create-virtualenv step (success) 07:48:07 INFO - [mozharness: 2016-08-02 14:48:07.035926Z] Running install step. 07:48:07 INFO - Running pre-action listener: _resource_record_pre_action 07:48:07 INFO - Running main action method: install 07:48:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:48:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:48:07 INFO - Reading from file tmpfile_stdout 07:48:07 INFO - Detecting whether we're running mozinstall >=1.0... 07:48:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:48:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:48:07 INFO - Reading from file tmpfile_stdout 07:48:07 INFO - Output received: 07:48:07 INFO - Usage: mozinstall [options] installer 07:48:07 INFO - Options: 07:48:07 INFO - -h, --help show this help message and exit 07:48:07 INFO - -d DEST, --destination=DEST 07:48:07 INFO - Directory to install application into. [default: 07:48:07 INFO - "/builds/slave/test"] 07:48:07 INFO - --app=APP Application being installed. [default: firefox] 07:48:07 INFO - mkdir: /builds/slave/test/build/application 07:48:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:48:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:48:24 INFO - Reading from file tmpfile_stdout 07:48:24 INFO - Output received: 07:48:24 INFO - /builds/slave/test/build/application/firefox/firefox 07:48:24 INFO - Running post-action listener: _resource_record_post_action 07:48:24 INFO - [mozharness: 2016-08-02 14:48:24.213848Z] Finished install step (success) 07:48:24 INFO - [mozharness: 2016-08-02 14:48:24.214125Z] Running run-tests step. 07:48:24 INFO - Running pre-action listener: _resource_record_pre_action 07:48:24 INFO - Running main action method: run_tests 07:48:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:48:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:48:24 INFO - Python 2.7.3 07:48:24 INFO - Return code: 0 07:48:24 INFO - grabbing minidump binary from tooltool 07:48: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')]} 07:48:24 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 0x1306570>, '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 0x1307470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1307900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:48:24 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 07:48:24 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 07:48:24 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 07:48:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:48:24 INFO - Return code: 0 07:48:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:48:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:48:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:48:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:48:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:48:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470137583/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 07:48:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470137583/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --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 07:48:24 INFO - Using env: {'DISPLAY': ':0', 07:48:24 INFO - 'HOME': '/home/cltbld', 07:48:24 INFO - 'LANG': 'en_US.UTF-8', 07:48:24 INFO - 'LANGUAGE': 'en_US:en', 07:48:24 INFO - 'LOGNAME': 'cltbld', 07:48:24 INFO - 'MAIL': '/var/mail/cltbld', 07:48:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:48:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:48:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:24 INFO - 'MOZ_NO_REMOTE': '1', 07:48:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:48:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:48:24 INFO - 'NO_EM_RESTART': '1', 07:48:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:48:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:24 INFO - 'PWD': '/builds/slave/test', 07:48:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:48:24 INFO - 'SHELL': '/bin/bash', 07:48:24 INFO - 'SHLVL': '1', 07:48:24 INFO - 'TERM': 'linux', 07:48:24 INFO - 'TMOUT': '86400', 07:48:24 INFO - 'USER': 'cltbld', 07:48:24 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1470149256.774787-359842650', 07:48:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:24 INFO - '_': '/tools/buildbot/bin/python'} 07:48:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470137583/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 07:48:24 INFO - mozversion application_buildid: 20160802043303 07:48:24 INFO - mozversion application_changeset: 8248ff77be0fa18183018e081ad62c9fb050b6d6 07:48:24 INFO - mozversion application_display_name: Nightly 07:48:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:48:24 INFO - mozversion application_name: Firefox 07:48:24 INFO - mozversion application_remotingname: firefox 07:48:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:48:24 INFO - mozversion application_vendor: Mozilla 07:48:24 INFO - mozversion application_version: 51.0a1 07:48:24 INFO - mozversion platform_buildid: 20160802043303 07:48:24 INFO - mozversion platform_changeset: 8248ff77be0fa18183018e081ad62c9fb050b6d6 07:48:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:48:24 INFO - mozversion platform_version: 51.0a1 07:48:24 INFO - using testdate: 1470149304 07:48:24 INFO - actual date: 1470149304 07:48:24 INFO - starting webserver on 'localhost:46949' 07:48:24 INFO - SUITE-START | Running 2 tests 07:48:24 INFO - TEST-START | dromaeo_css 07:48:24 INFO - operating with platform_type : linux_ 07:48:24 INFO - Initialising browser for dromaeo_css test... 07:48:24 INFO - TEST-INFO | started process 7541 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS94Xim/profile http://localhost:46949/getInfo.html) 07:48:29 INFO - PROCESS | 7541 | __metrics Screen width/height:1600/1200 07:48:29 INFO - PROCESS | 7541 | colorDepth:24 07:48:29 INFO - PROCESS | 7541 | Browser inner width/height: 1024/697 07:48:29 INFO - PROCESS | 7541 | __metrics 07:48:29 ERROR - PROCESS | 7541 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 07:48:30 INFO - TEST-INFO | 7541: exit 0 07:48:30 INFO - Browser initialized. 07:48:30 INFO - Running cycle 1/1 for dromaeo_css test... 07:48:30 INFO - TEST-INFO | started process 7659 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS94Xim/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:48:42 INFO - PROCESS | 7659 | RSS: Main: 162934784 07:48:42 INFO - PROCESS | 7659 | 07:49:32 INFO - PROCESS | 7659 | 1470149372114 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] 07:51:40 INFO - PROCESS | 7659 | Cycle 1(1): loaded http://localhost:46949/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46949/tests/dromaeo/cssquery-ext.html) 07:51:41 INFO - PROCESS | 7659 | RSS: Main: 168210432 07:51:41 INFO - PROCESS | 7659 | 07:54:44 INFO - PROCESS | 7659 | Cycle 1(1): loaded http://localhost:46949/tests/dromaeo/cssquery-ext.html (next: http://localhost:46949/tests/dromaeo/cssquery-jquery.html) 07:54:44 INFO - PROCESS | 7659 | RSS: Main: 166227968 07:54:44 INFO - PROCESS | 7659 | 07:57:46 INFO - PROCESS | 7659 | Cycle 1(1): loaded http://localhost:46949/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46949/tests/dromaeo/cssquery-mootools.html) 07:57:47 INFO - PROCESS | 7659 | RSS: Main: 169365504 07:57:47 INFO - PROCESS | 7659 | 08:00:49 INFO - PROCESS | 7659 | Cycle 1(1): loaded http://localhost:46949/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46949/tests/dromaeo/cssquery-prototype.html) 08:00:49 INFO - PROCESS | 7659 | RSS: Main: 164286464 08:00:49 INFO - PROCESS | 7659 | 08:03:52 INFO - PROCESS | 7659 | Cycle 1(1): loaded http://localhost:46949/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46949/tests/dromaeo/cssquery-yui.html) 08:03:52 INFO - PROCESS | 7659 | RSS: Main: 166178816 08:03:52 INFO - PROCESS | 7659 | 08:06:55 INFO - PROCESS | 7659 | Cycle 1(1): loaded http://localhost:46949/tests/dromaeo/cssquery-yui.html (next: http://localhost:46949/tests/dromaeo/cssquery-dojo.html) 08:06:56 INFO - PROCESS | 7659 | RSS: Main: 169181184 08:06:56 INFO - PROCESS | 7659 | 08:06:56 INFO - PROCESS | 7659 | __start_tp_report 08:06:56 INFO - PROCESS | 7659 | _x_x_mozilla_page_load 08:06:56 INFO - PROCESS | 7659 | _x_x_mozilla_page_load_details 08:06:56 INFO - PROCESS | 7659 | |i|pagename|runs| 08:06:56 INFO - PROCESS | 7659 | |0;dojo.html;3103.5344698295253;3119;3151.2279491524578;3155.1007962730628;3157.1002264354647;5351.678899266047;5377.139657654776;5448.536874365679;5463.78144874205;5513.6140470167;5404.32445944257;5409.053415652264;5416.891662166754;5473.397926228112;5491.478309560595;4859.902801943959;4898.608111351093;4956.826511072113;4975.402951645808;4978.452370239271;4936.111499930011;4949.579285760715;5107.361579802525;5107.948920510785;5125.692458452486;4896.314515967767;4980;4997.950020499821;5082.517160869711;5105.693658380509;4910.091633047862;4932.457429682732;4941;4947.554720075211;5000.249962505617;4902.950970490321;4903.239997800347;4910.238912968495;4924.359833221694;4970.925436118461;5356.946430535684;5389.0569150398915;5398.514133727944;5400.756965936543;5421.620486565942;5776.133579963039;5785.132230165466;5788.0739081746715;5825.038868586678;5837.095250236178;5822.708864556797;5842.152887831283;5849.941500584982;5856.092305692625;5856.180134781134;5337.119375303109;5356.678599284017;5369.355677318707;5400.864978375533;5402.486763757476;5909.734061967221;5914.053751399755;5921.585489015728;5958.493528050164;5976.402359763989;5671.574631902624;5679.034564124109;5680.062789639664;5680.318361796611;5683.630564013326;5620;5730.656160630376;5734.139879018181;5773.451522105393;5838.737256823453;5659.830205093854;5832.708364581838;5836.533077353802;5849.298084229919;5883.058710606282;5760.395158508296;5784.623999440023;5816.970915145397;5843.3864444233595;5875.500582450454;4465.173942820588;4468.687191896601;4470.6870519064005;4471.19518486669;4512.571305726016;3937.5274967004143;3974.364101743707;3975.1254723960683;4006.899827504336;4048.2308361411237;5486.286782718221;5649.830505084854;5660.2075709400715;5660.2075709400715;5663.971680141655;5925.525957923356;5926.051831706906;5937.524998000236;5939.910901336483;5940.079287710412;5489.64317319373;5555.638883472561;5581.525570326487;5581.553475721932;5681.914771278434;5069.8732531687;5072.9854029193575;5076.796928122908;5078.21287700407;5078.7460626968505;6023.397660233942;6094.177286066413;6097.664628445478;6100.572959892765;6112.8777424452155;5693.202951586864;5865.501432378295;5911;5926.851828704317;5928.49607783326;6026.186464827192;6033.78881739137;6037.305709843425;6040.7583696651645;6074.574779765374;5645.971770141123;5689.715514224355;5699.116636921284;5735.54115670737;5736.598438109292;5725.570582206268;5833.854153646193;5866.032104702847;5884.617499862496;5913.467787898938;5715.514181294637;5721.542276617777;5754.309482862083;5755.050416681368;5756.856078598069;5696.458836410535;5708.600397972102;5716.771329146954;5738.483536481736;5746.367899530965;5559.749811258423;5615.241942337732;5681.17622944679;5690.914636280542;5709.68596727184;5746.195532625519;5756.798512052058;5783.768649253982;5797.536197104306;5802.448767367094;5475.534579560782;5635.380108188178;5664.0937450007805;5665.150227465749;5665.433456654301 08:06:56 INFO - PROCESS | 7659 | |1;ext.html;574.3796699564471;583.941605839416;587.4008511318456;593.2910172344051;609.7225762278164;39995.80002099989;44057.11885762283;44253.55746442539;44273.55726442735;44288;43088.56911430885;43637.7818110909;43749.78125109378;43906;44009.55990440094;8801.515916624583;8890.066543012988;8899.599518021705;8915.465072095663;8915.509646969414;8853.335999800009;8887.244584210317;8898.644054237822;8906.242969347613;8906.33202509811;8951.462912225288;8990.505522196276;9003.054679258681;9027.097290270953;9036.68371606994;8923;8925.55372231389;8964.058773828752;8968.103189681045;8995.685151019716;8769.429987050822;8832.955835220848;8835.249003834682;8845.071267516947;8888.466691998501;41606.1678766426;41978.58021419777;41992.790036049926;42049;42089.31642734287;3224.532442795805;3589.4053528656136;3593.9101522462147;3617.1318883468043;3668.1196512836996;28889.963651956255;30932.226694332596;31005;31139.688603113904;31332.37335253305;4303.31147016479;4327.2643650579475;4327.939654784598;4346.717463364871;4425.867223983286;303844.4807775969;303850;304748;305970;306034;35705.82147089248;35785;35843.4623480648;35874;35970.46044309285;36831.4475282871;37090.814545927096;37340.813295933345;37930;37987.620123798406;15492.690146197014;15932.044077355396;15998.200089995686;16007.759883601755;16012.119333436773;12101.15291929574;12107.334096624594;12112.636620901387;12160.574379896661;12201.08491863096;19511.219551218077;19546.200791429;19550.770336074012;19602.509937251398;19616.60766784656;7114.857702845914;7161.641917904188;7267.418606511466;7281.890771638429;7364.77905662831;1000.3797645459862;1077.3535878472853;1120.8935151160626;1138.772245550893;1141.6860363399965;32594;32743.50884736731;33151.83424082864;33277.16807079794;33391.49563782726;1117.580907159815;1129.181343525937;1138.4023387721347;1202.2185579373477;1204.0909113619161;17236.82763172352;17440.563985900455;17512.299508019536;17512.737308940123;17610.559736006704;561728;562722;564424.1778791161;565328;566984;58693.70653146707;59224.703876480344;59431;59525;59584.70207648934;1338.6184937292826;1353.9458421663023;1381.0746799644262;1388.5973067810423;1390.4994202087241;30168.396632066797;30917.536236956912;31724.206894827814;31954.041378758673;32174;51825.22262165995;52099.21851172311;52411.73794131005;52531.21203181879;52616.47383526269;439831;439971;441428;441796;444503;29368.706312936596;29421.55867661944;29575;29714.851425742734;29906;48277.5172248273;48528;48607.27089093737;50236.995260095326;50360.748196258784;40047.799761001006;42783.572164279205;42923;42953.3556996639;43201;40418.59581404148;41873;42195.57804421917;42565;42778.35832462453;36242.27515449729;41290.79354603208;42047.15905681808;43625.78187109171;43702.344464832415;34783.82608086943;37586.43620345752;38396.808015959745;38536.6146338533;38944;28657.570136448387;28696.426071478036;29074.418511630072;29098.27254318659;29191.416171676025 08:06:56 INFO - PROCESS | 7659 | |2;jquery.html;391.1590081325152;392.5564112552815;404.30661415672125;407.56797794338;415.6155556110597;18757.71863422048;19573;19949.401517954448;20209.292674756387;20239.797602023995;15881.126538040404;16115.194240287969;17856.553586160353;20076.498087547818;20229.696554551658;5617.578681598897;5631.465010823976;5652.660840349572;5701.942980570183;5812.244408226925;5587.329520457531;5606.131049687305;5752.223449834281;5753.712314384285;5754.16564598133;5524.1989911462815;5591.189277554752;5650.124230744241;5714.657120572758;5720.485156335929;5628.690422026807;5636.577256705764;5662.348829884575;5669.886602267973;5687.601867869251;5078.13671675816;5096.337476128079;5127.948720512784;5137.357830271216;5140.588752899759;23425.297241082793;23779.524409511887;24120.517589648283;24399.146029888867;24552.508949821084;2277.6583512473094;2299.586074506588;2341.7658234176615;2377.1442280778906;2428.1258746851117;14889.776653350209;15145.318460669187;15336.769948450783;15460.149691766948;15924.681506369923;1989.801019898013;1993.401979406187;2012.4868158619604;2024.2813801100692;2058.166442590753;80423.5978820108;80429.59785201037;81499;82922;83936;10409.167266618653;10648.574057037787;11053.447327633587;11890.10824188172;12038.638840834614;15371.846281537042;15385.230738463031;15414.691706165813;15431.84568154304;15440.922795386175;7797.259260370256;8062.153473885158;8072.878906816402;8265.710700125586;8278.71024514139;7592.392608591299;7673.194314596999;7934.920650793533;7955.880661790078;7963.203679631991;6499.707513161919;6682.231543372574;6730.192376914802;6763.695633696496;6822.249552549315;1913.9330123445613;1940.5827747034455;1947;1994.5811379610154;1997.6304383689064;943.6602822983721;944.0182210501002;1007.450939238117;1047.7904419116207;1064.5316060933164;19711.704324435144;20816.47958801012;20887.68668469974;20898.895505522374;20936;1033.1373303291684;1044.3785947361307;1052.6421016854306;1085.2457542008228;1088.3198001249218;11368.94315528417;11589.27859705072;11816.35010074437;11899.16705830601;11947.402629868471;487607;491836;494522;509500;518446;80742.19257807346;82747;83497.58251208706;83771;86451.56774216089;985.393982700634;1049.9895001050045;1062.7502536903821;1069.2942657845786;1069.5828626835541;14893.404263829325;16314.592135196715;17700.380486682905;18535.35126270574;18749.34377296788;43068.56931430771;43784;45108;45141;45585.316220256056;61397;62484.68757656364;63386;63777.681111596;65107;8235.752927412188;8329.95835020821;8472.44929079608;8541.87187192205;8575.742727718178;12182;12982.80525792095;13002.154859934075;13095.672608184872;13236.669083272995;11289.435528223392;11368.886311137114;11484.425778711198;11754.941225293818;12141.817872732092;11354.54581816718;11488.770224595628;11574.479148438171;11640.94179529097;12000.03999680006;11429.828552571551;11462.197646164688;11574.421278935852;11645.941770291094;12095.57665481704;8162.959410036411;8222.83554328898;8430.241278284984;8455;8617.784555386166;10313.690589282334;11042.723931901446;11069.944650276697;11401.20191586581;11686.824697629372 08:06:56 INFO - PROCESS | 7659 | |3;mootools.html;1480.740870347689;1487.4942519543356;1641.1466037660416;1744.9825501744979;1768.9027103509302;8008.95995520023;8573.228409443149;8681.21869031787;9382.71851844445;9402.106799854002;8670.263027642657;8911.955440222806;8963.596638151283;8965;8970.50662213578;2315.722113346401;2347.6830627865274;2355.187460326185;2369.8815059247054;2372.774586414288;2227.1091563374616;2284.748677645466;2304.942376440594;2307.4231442139467;2307.61924282494;2302.3898666853297;2318.597248664559;2325.651152327156;2342.3441436397834;2345.2026311054237;2298.482841360697;2309.988450057756;2312.722473303206;2312.8612283262974;2341.2390972933695;2294.4263934016494;2305.7348404933477;2306.5386922615544;2306.757790432014;2307.526956973833;9214.723558293263;9249.075092490697;9288.674896378594;9294.581743821544;9321.953390233073;5394.81314110895;5462.180672899057;5522.3649280332875;5528.44715528448;5538.418466061086;3420.3672320620763;3431.2892814676375;3547.5565554305713;3591.730620203495;3681.245344704329;1142.5144313666658;1191.255465334166;1195.1275568834712;1207.643745095199;1214.769193853165;12929.741405171844;13016.349182540835;13102.80345794814;13103.541376051793;13141.40863661128;4677.0871198352115;4738.431388233434;4762.999770048329;4858.02839432115;4894.070126675921;10910.836337454944;11003.889961100447;11004.119670426348;11010.889891101147;11012.559497620005;5472.425395333512;5494;5508.03609368359;5515.062439385234;5530.225768392428;4455.866324010285;4938.9012219755405;4979.6265280104135;5004.274380214922;5066;4092.6660183038066;4140.937885931713;4170.895727606834;4185.991081803134;4209.852655157055;1331.1347624044256;1339.3504150487006;1342.8657134286689;1356.504875720355;1365.5493687083438;841.2386789955101;867.7743786615399;999.6201443451442;1001.4692213127055;1007.8460163113194;5844.795432159854;6340.682965851689;6488.416042556099;6537.248216455074;6562.179727534059;955.412421360858;1008.1078245752561;1027.5889644142403;1035.3477309295097;1052.1740433759462;4274.380214868826;4371.803268852909;4392.648588112943;4407.0524837160165;4409.933850992237;11393.943030284796;11533.192676512563;11556.364399958084;11578.247413918069;11612.88387116118;11597.072234221241;11619.825702614467;11646.359450230319;11651.941740291413;11674.182807203584;7988.440809143304;8260.917390826135;8262.545559994138;8434.536100514408;8645.956770216235;6121.602095863755;6167.6916154193;6212.161358216764;6238.282597501164;6337.714802833976;10644.627438039632;10707.94646026796;10797.838032429363;10845.891541084804;10932.508037138188;10663.253572250178;10841;10880.292780969212;10923.726906827393;10936.835947460953;7414.369778568882;8088.83822323562;8170.7957301067945;8186.222308880647;8360.707375241838;9092.318076144184;9162.175404213653;9168.129027742354;9169.35814492979;9175.449473031373;7921.722739704082;8045.9597702011115;8053.154418785943;8285.585720714062;8326.791830204293;7801.2198780121535;7828.373730101464;7862.1351651319455;7947.920520794718;8031.116577176389;7205.891911621435;7264;7318.121825380988;7348.595827229554;7354.669039893324;5467.289252397163;5504.779808807763;5532.778688852401;5579.521426821814;5808.07070868659;5466.781328746964;5503;5596.468335508121;5640.633358831663;5643.604947653789 08:06:56 INFO - PROCESS | 7659 | |4;prototype.html;324.9983750081249;325.7980052367532;333.2202645808808;335.99832000840007;337.7061956098195;5551.639143455673;5609.411011843759;5610.775568977241;5625.831225063244;5645.5483561315095;5521.668699878011;5552.278203833496;5561.972190139044;5590.161475778636;5616.550675945925;4144.70987030908;4145.170965806836;4250.9149817003645;4281.544274946517;4307.1170410066015;4280.6361459275995;4288.399624052635;4292.892677683051;4305.892352691177;4340.242201908232;4231.894202644943;4256.87229383119;4263.87208383749;4267.978660106711;4271.700980931336;4007.9198416031663;4184.497860256758;4221.403836640475;4224.091820258628;4271.209826182151;3657.3051120287328;3658.70730341572;3674.5223120994365;3705.8702945397054;3711.480392745018;5462.235287059775;5496.890062198773;5498.725063746837;5506.229127922094;5513.228148059275;4662.440507139131;4905.607551395879;4909.754512274372;4920.237363208708;4965.255211718235;5784.710764461802;5821.53427725781;5822.184894114827;5860.443257890493;5869.325027621793;4077.245709543744;4083.9387409188885;4105.158442519306;4113.568075352075;4131.29767939451;5888.146218798293;6029.366916473751;6039.8188054358;6040.335563088057;6099.420555047263;4193.1404062167185;4216.768077755692;4223.092035212444;4223.619874211336;4240.660747140221;4278.657707383401;4280.5291417944;4288.24955632763;4295.269804133305;4298.290782020931;4612.377329060534;4824.8793780155775;4885.364902562644;4938.802447902043;4967.205247160437;5799.652020878761;5821.7380217890295;5822.272215973004;5827;5857.853553661107;1496.518446737722;1517.9392824287127;1518.4381778741936;1521.7445607373961;1524.0322395279077;936.6159874451579;978.3640633588083;989.8122253296074;993.2997236947934;1016.9745756356002;5615.859603509945;5630.155476678449;5642.4357564244065;5653.830385088454;5661.631993920382;5923.437273459014;5958.910616340759;5973.761049558056;6004.819855404345;6017.2779266488305;5328.17413300939;5650.74571644277;5656.490915817596;5698.430156984351;5716.828495145152;3174.587303650511;3189.3734195560432;3214.5017522284083;3214.9678503215137;3225.951610725841;6136.668066134929;6141.447269745744;6173.41352571505;6297.842553936188;6300.684965751694;6116.48009919153;6122.204113465221;6130.877382452326;6138.78514252008;6148.44663980244;6098.35967223444;6256.405641464054;6259.6870156492;6261.906071408933;6283.748650054038;5891.823245302648;5949.2266005419015;5969.432903874125;5988.311344195299;5996.400359963969;5933.647489168606;5956.463918247378;5957.225560677084;5978.551608629457;5998.940010599838;6018.398160183947;6130.601510901777;6164.291106522807;6220.626762394271;6238.656873871981;4134.834606615702;4177.561356057692;4181.958180418157;4198.99224186187;4202.4326715894185;5769.509591684754;6001.189839371804;6046.606970546901;6050.03373903492;6053.757849685963;5765.279340082489;5811.331696854916;5813.622114562709;5829.446202610745;5880.647161170173;5797.4782269595935;5816.680082595498;5823.621464604787;5829.125631155361;5873.970630146822;5563.221149039056;5697.715114244188;5759.856003599776;5771.797987070432;5775.6823374714795;5774.220480235114;5810.477057064884;5821.952048631287;5822.689894773812;5843.386444423274;5633.492985631313;5705.686187259575;5719.370869204301;5750.568707346882;5759.716961332 08:06:56 INFO - PROCESS | 7659 | |5;yui.html;746.6229554075189;757.212499001039;770.456827936305;789.0964845252187;800.7637746864674;16012.519624411272;17279.481615551522;17294.91352543239;17331.046792426412;17350.913245433785;15590.45433409831;16014.279357428915;16163.191840407962;16696.66606667866;16773.83226167738;796.8047828282065;818.9017317921857;824.3775949158377;826.7065191856894;826.904905935816;793.0562630469751;804.0552350987596;805.8348038652092;816.4774544291658;818.4475479051616;871.7951281448854;873.7204094689702;875.0199776250608;875.1248751248751;876.408424313589;862.107718511344;865.03548543374;867.249828898005;868.2055918834259;869.5565261716539;628.1833616298838;629.0469938043867;631.0313668518802;631.8104568629393;633.8383712153371;15680.451184208498;15759.763603545956;15832.050076995418;15909.284082216329;15971.440999565075;15128.54614361571;15355.232238388036;15540.922295388564;15552.844471555365;15563.066216026962;12763.744725105538;12915.935420322932;12991.415386307639;13061.477540898353;13630.182189068588;3975.3043217436834;4001.2197621463824;4057.3305404608204;4067.715259931806;4154.439150714645;85284;86843.69734453988;87428.56285718594;88540.5572972131;88584;11366.318020918772;11523.596674116367;11533.826992595117;11558.30650160993;11592.130590205768;21475.892620536797;21637.35087947364;21670.24154154597;21737.021834017192;21830.345089647337;8377.45546539473;8448.746537603882;8450.61972211252;8856.424332418372;8888.511131887679;4776.665633405698;4874.5856602188505;5066.290719299301;5079.085764562415;5220.347456567929;3285.9835700821823;3355.379254837863;3375;3377.8142202178624;3404.1149301181376;603.408659513679;607.2439812433461;614.883172197281;622.8380621038563;644.7968889799698;577.6620676903974;604.597942368329;652.9706163222667;652.9836754081091;713.5255055388109;9562.709034280422;9708.514574271258;9922.851157232648;10066.69799906004;10254.48727563619;597.0655923479741;615.2678312807744;732.5458215906066;736.2821249281907;756.7237958145238;4519.163954668331;4815.798937147872;4966.801327946914;5215.47845215483;5289.9471005290225;72400;112212.43893780479;112494;113713;117021;91279.54360228157;94354;94532.52733736426;95724;96006;56128.43871561314;57696.13455798166;68246;74505.62747186446;85516.57241713752;9894.653687120915;9991.600335986479;10123.949380253052;10264.332818366782;10429.530671119666;48928;50214;50750.74624626853;50826.49173508218;52667.209991849384;67849.32150678628;72136.27863721506;72578;73489.6325518369;73673.6316318415;12377.690557736129;12444.128910976146;12498.750024999266;12774.297413642338;12803.167794093726;15072.504182933386;15493.225338733244;15515.844841551892;15532.999950487607;15620.218989050274;14735.26323683833;14978.775318370452;14990.400383984519;15193.544193674208;15799.68400631958;13311.400986955803;13487.865121348661;14417;14813.629659258604;14972.861126938338;14149.151050936976;14207.900808818733;14890.627734306729;14895.92552037233;15534.378624854879;11498.576908798415;11613.709657258636;11669.299842009506;11870.82193767077;12064.819027714766;10955.780884382108;10963;12137.271763694207;12148.149629525848;12175.269483830998 08:06:56 INFO - PROCESS | 7659 | __end_tp_report 08:06:56 INFO - PROCESS | 7659 | __start_cc_report 08:06:56 INFO - PROCESS | 7659 | _x_x_mozilla_cycle_collect,347 08:06:56 INFO - PROCESS | 7659 | __end_cc_report 08:06:56 INFO - PROCESS | 7659 | __startTimestamp1470150416081__endTimestamp 08:06:56 INFO - PROCESS | 7659 | 08:06:56 INFO - PROCESS | 7659 | ------- Summary: start ------- 08:06:56 INFO - PROCESS | 7659 | Number of tests: 6 08:06:56 INFO - PROCESS | 7659 | 08:06:56 INFO - PROCESS | 7659 | [#0] dojo.html Cycles:165 Average:5424.04 Median:5665.15 stddev:616.45 (10.9%) stddev-sans-first:590.85 08:06:56 INFO - PROCESS | 7659 | Values: 3103.5 3119.0 3151.2 3155.1 3157.1 5351.7 5377.1 5448.5 5463.8 5513.6 5404.3 5409.1 5416.9 5473.4 5491.5 4859.9 4898.6 4956.8 4975.4 4978.5 4936.1 4949.6 5107.4 5107.9 5125.7 4896.3 4980.0 4998.0 5082.5 5105.7 4910.1 4932.5 4941.0 4947.6 5000.2 4903.0 4903.2 4910.2 4924.4 4970.9 5356.9 5389.1 5398.5 5400.8 5421.6 5776.1 5785.1 5788.1 5825.0 5837.1 5822.7 5842.2 5849.9 5856.1 5856.2 5337.1 5356.7 5369.4 5400.9 5402.5 5909.7 5914.1 5921.6 5958.5 5976.4 5671.6 5679.0 5680.1 5680.3 5683.6 5620.0 5730.7 5734.1 5773.5 5838.7 5659.8 5832.7 5836.5 5849.3 5883.1 5760.4 5784.6 5817.0 5843.4 5875.5 4465.2 4468.7 4470.7 4471.2 4512.6 3937.5 3974.4 3975.1 4006.9 4048.2 5486.3 5649.8 5660.2 5660.2 5664.0 5925.5 5926.1 5937.5 5939.9 5940.1 5489.6 5555.6 5581.5 5581.6 5681.9 5069.9 5073.0 5076.8 5078.2 5078.7 6023.4 6094.2 6097.7 6100.6 6112.9 5693.2 5865.5 5911.0 5926.9 5928.5 6026.2 6033.8 6037.3 6040.8 6074.6 5646.0 5689.7 5699.1 5735.5 5736.6 5725.6 5833.9 5866.0 5884.6 5913.5 5715.5 5721.5 5754.3 5755.1 5756.9 5696.5 5708.6 5716.8 5738.5 5746.4 5559.7 5615.2 5681.2 5690.9 5709.7 5746.2 5756.8 5783.8 5797.5 5802.4 5475.5 5635.4 5664.1 5665.2 5665.4 08:06:56 INFO - PROCESS | 7659 | 08:06:56 INFO - PROCESS | 7659 | [#1] ext.html Cycles:180 Average:58879.05 Median:41739.58 stddev:119515.62 (286.3%) stddev-sans-first:119770.72 08:06:56 INFO - PROCESS | 7659 | Values: 574.4 583.9 587.4 593.3 609.7 39995.8 44057.1 44253.6 44273.6 44288.0 43088.6 43637.8 43749.8 43906.0 44009.6 8801.5 8890.1 8899.6 8915.5 8915.5 8853.3 8887.2 8898.6 8906.2 8906.3 8951.5 8990.5 9003.1 9027.1 9036.7 8923.0 8925.6 8964.1 8968.1 8995.7 8769.4 8833.0 8835.2 8845.1 8888.5 41606.2 41978.6 41992.8 42049.0 42089.3 3224.5 3589.4 3593.9 3617.1 3668.1 28890.0 30932.2 31005.0 31139.7 31332.4 4303.3 4327.3 4327.9 4346.7 4425.9 303844.5 303850.0 304748.0 305970.0 306034.0 35705.8 35785.0 35843.5 35874.0 35970.5 36831.4 37090.8 37340.8 37930.0 37987.6 15492.7 15932.0 15998.2 16007.8 16012.1 12101.2 12107.3 12112.6 12160.6 12201.1 19511.2 19546.2 19550.8 19602.5 19616.6 7114.9 7161.6 7267.4 7281.9 7364.8 1000.4 1077.4 1120.9 1138.8 1141.7 32594.0 32743.5 33151.8 33277.2 33391.5 1117.6 1129.2 1138.4 1202.2 1204.1 17236.8 17440.6 17512.3 17512.7 17610.6 561728.0 562722.0 564424.2 565328.0 566984.0 58693.7 59224.7 59431.0 59525.0 59584.7 1338.6 1353.9 1381.1 1388.6 1390.5 30168.4 30917.5 31724.2 31954.0 32174.0 51825.2 52099.2 52411.7 52531.2 52616.5 439831.0 439971.0 441428.0 441796.0 444503.0 29368.7 29421.6 29575.0 29714.9 29906.0 48277.5 48528.0 48607.3 50237.0 50360.7 40047.8 42783.6 42923.0 42953.4 43201.0 40418.6 41873.0 42195.6 42565.0 42778.4 36242.3 41290.8 42047.2 43625.8 43702.3 34783.8 37586.4 38396.8 38536.6 38944.0 28657.6 28696.4 29074.4 29098.3 29191.4 08:06:56 INFO - PROCESS | 7659 | 08:06:56 INFO - PROCESS | 7659 | [#2] jquery.html Cycles:180 Average:29521.06 Median:12901.22 stddev:82342.60 (638.3%) stddev-sans-first:82544.54 08:06:56 INFO - PROCESS | 7659 | Values: 391.2 392.6 404.3 407.6 415.6 18757.7 19573.0 19949.4 20209.3 20239.8 15881.1 16115.2 17856.6 20076.5 20229.7 5617.6 5631.5 5652.7 5701.9 5812.2 5587.3 5606.1 5752.2 5753.7 5754.2 5524.2 5591.2 5650.1 5714.7 5720.5 5628.7 5636.6 5662.3 5669.9 5687.6 5078.1 5096.3 5127.9 5137.4 5140.6 23425.3 23779.5 24120.5 24399.1 24552.5 2277.7 2299.6 2341.8 2377.1 2428.1 14889.8 15145.3 15336.8 15460.1 15924.7 1989.8 1993.4 2012.5 2024.3 2058.2 80423.6 80429.6 81499.0 82922.0 83936.0 10409.2 10648.6 11053.4 11890.1 12038.6 15371.8 15385.2 15414.7 15431.8 15440.9 7797.3 8062.2 8072.9 8265.7 8278.7 7592.4 7673.2 7934.9 7955.9 7963.2 6499.7 6682.2 6730.2 6763.7 6822.2 1913.9 1940.6 1947.0 1994.6 1997.6 943.7 944.0 1007.5 1047.8 1064.5 19711.7 20816.5 20887.7 20898.9 20936.0 1033.1 1044.4 1052.6 1085.2 1088.3 11368.9 11589.3 11816.4 11899.2 11947.4 487607.0 491836.0 494522.0 509500.0 518446.0 80742.2 82747.0 83497.6 83771.0 86451.6 985.4 1050.0 1062.8 1069.3 1069.6 14893.4 16314.6 17700.4 18535.4 18749.3 43068.6 43784.0 45108.0 45141.0 45585.3 61397.0 62484.7 63386.0 63777.7 65107.0 8235.8 8330.0 8472.4 8541.9 8575.7 12182.0 12982.8 13002.2 13095.7 13236.7 11289.4 11368.9 11484.4 11754.9 12141.8 11354.5 11488.8 11574.5 11640.9 12000.0 11429.8 11462.2 11574.4 11645.9 12095.6 8163.0 8222.8 8430.2 8455.0 8617.8 10313.7 11042.7 11069.9 11401.2 11686.8 08:06:56 INFO - PROCESS | 7659 | 08:06:56 INFO - PROCESS | 7659 | [#3] mootools.html Cycles:180 Average:6078.57 Median:4432.90 stddev:3499.24 (78.9%) stddev-sans-first:3492.00 08:06:56 INFO - PROCESS | 7659 | Values: 1480.7 1487.5 1641.1 1745.0 1768.9 8009.0 8573.2 8681.2 9382.7 9402.1 8670.3 8912.0 8963.6 8965.0 8970.5 2315.7 2347.7 2355.2 2369.9 2372.8 2227.1 2284.7 2304.9 2307.4 2307.6 2302.4 2318.6 2325.7 2342.3 2345.2 2298.5 2310.0 2312.7 2312.9 2341.2 2294.4 2305.7 2306.5 2306.8 2307.5 9214.7 9249.1 9288.7 9294.6 9322.0 5394.8 5462.2 5522.4 5528.4 5538.4 3420.4 3431.3 3547.6 3591.7 3681.2 1142.5 1191.3 1195.1 1207.6 1214.8 12929.7 13016.3 13102.8 13103.5 13141.4 4677.1 4738.4 4763.0 4858.0 4894.1 10910.8 11003.9 11004.1 11010.9 11012.6 5472.4 5494.0 5508.0 5515.1 5530.2 4455.9 4938.9 4979.6 5004.3 5066.0 4092.7 4140.9 4170.9 4186.0 4209.9 1331.1 1339.4 1342.9 1356.5 1365.5 841.2 867.8 999.6 1001.5 1007.8 5844.8 6340.7 6488.4 6537.2 6562.2 955.4 1008.1 1027.6 1035.3 1052.2 4274.4 4371.8 4392.6 4407.1 4409.9 11393.9 11533.2 11556.4 11578.2 11612.9 11597.1 11619.8 11646.4 11651.9 11674.2 7988.4 8260.9 8262.5 8434.5 8646.0 6121.6 6167.7 6212.2 6238.3 6337.7 10644.6 10707.9 10797.8 10845.9 10932.5 10663.3 10841.0 10880.3 10923.7 10936.8 7414.4 8088.8 8170.8 8186.2 8360.7 9092.3 9162.2 9168.1 9169.4 9175.4 7921.7 8046.0 8053.2 8285.6 8326.8 7801.2 7828.4 7862.1 7947.9 8031.1 7205.9 7264.0 7318.1 7348.6 7354.7 5467.3 5504.8 5532.8 5579.5 5808.1 5466.8 5503.0 5596.5 5640.6 5643.6 08:06:56 INFO - PROCESS | 7659 | 08:06:56 INFO - PROCESS | 7659 | [#4] prototype.html Cycles:180 Average:4897.04 Median:5643.99 stddev:1459.44 (25.9%) stddev-sans-first:1422.62 08:06:56 INFO - PROCESS | 7659 | Values: 325.0 325.8 333.2 336.0 337.7 5551.6 5609.4 5610.8 5625.8 5645.5 5521.7 5552.3 5562.0 5590.2 5616.6 4144.7 4145.2 4250.9 4281.5 4307.1 4280.6 4288.4 4292.9 4305.9 4340.2 4231.9 4256.9 4263.9 4268.0 4271.7 4007.9 4184.5 4221.4 4224.1 4271.2 3657.3 3658.7 3674.5 3705.9 3711.5 5462.2 5496.9 5498.7 5506.2 5513.2 4662.4 4905.6 4909.8 4920.2 4965.3 5784.7 5821.5 5822.2 5860.4 5869.3 4077.2 4083.9 4105.2 4113.6 4131.3 5888.1 6029.4 6039.8 6040.3 6099.4 4193.1 4216.8 4223.1 4223.6 4240.7 4278.7 4280.5 4288.2 4295.3 4298.3 4612.4 4824.9 4885.4 4938.8 4967.2 5799.7 5821.7 5822.3 5827.0 5857.9 1496.5 1517.9 1518.4 1521.7 1524.0 936.6 978.4 989.8 993.3 1017.0 5615.9 5630.2 5642.4 5653.8 5661.6 5923.4 5958.9 5973.8 6004.8 6017.3 5328.2 5650.7 5656.5 5698.4 5716.8 3174.6 3189.4 3214.5 3215.0 3226.0 6136.7 6141.4 6173.4 6297.8 6300.7 6116.5 6122.2 6130.9 6138.8 6148.4 6098.4 6256.4 6259.7 6261.9 6283.7 5891.8 5949.2 5969.4 5988.3 5996.4 5933.6 5956.5 5957.2 5978.6 5998.9 6018.4 6130.6 6164.3 6220.6 6238.7 4134.8 4177.6 4182.0 4199.0 4202.4 5769.5 6001.2 6046.6 6050.0 6053.8 5765.3 5811.3 5813.6 5829.4 5880.6 5797.5 5816.7 5823.6 5829.1 5874.0 5563.2 5697.7 5759.9 5771.8 5775.7 5774.2 5810.5 5822.0 5822.7 5843.4 5633.5 5705.7 5719.4 5750.6 5759.7 08:06:56 INFO - PROCESS | 7659 | 08:06:56 INFO - PROCESS | 7659 | [#5] yui.html Cycles:180 Average:20483.48 Median:4796.23 stddev:28413.83 (592.4%) stddev-sans-first:28454.89 08:06:56 INFO - PROCESS | 7659 | Values: 746.6 757.2 770.5 789.1 800.8 16012.5 17279.5 17294.9 17331.0 17350.9 15590.5 16014.3 16163.2 16696.7 16773.8 796.8 818.9 824.4 826.7 826.9 793.1 804.1 805.8 816.5 818.4 871.8 873.7 875.0 875.1 876.4 862.1 865.0 867.2 868.2 869.6 628.2 629.0 631.0 631.8 633.8 15680.5 15759.8 15832.1 15909.3 15971.4 15128.5 15355.2 15540.9 15552.8 15563.1 12763.7 12915.9 12991.4 13061.5 13630.2 3975.3 4001.2 4057.3 4067.7 4154.4 85284.0 86843.7 87428.6 88540.6 88584.0 11366.3 11523.6 11533.8 11558.3 11592.1 21475.9 21637.4 21670.2 21737.0 21830.3 8377.5 8448.7 8450.6 8856.4 8888.5 4776.7 4874.6 5066.3 5079.1 5220.3 3286.0 3355.4 3375.0 3377.8 3404.1 603.4 607.2 614.9 622.8 644.8 577.7 604.6 653.0 653.0 713.5 9562.7 9708.5 9922.9 10066.7 10254.5 597.1 615.3 732.5 736.3 756.7 4519.2 4815.8 4966.8 5215.5 5289.9 72400.0 112212.4 112494.0 113713.0 117021.0 91279.5 94354.0 94532.5 95724.0 96006.0 56128.4 57696.1 68246.0 74505.6 85516.6 9894.7 9991.6 10123.9 10264.3 10429.5 48928.0 50214.0 50750.7 50826.5 52667.2 67849.3 72136.3 72578.0 73489.6 73673.6 12377.7 12444.1 12498.8 12774.3 12803.2 15072.5 15493.2 15515.8 15533.0 15620.2 14735.3 14978.8 14990.4 15193.5 15799.7 13311.4 13487.9 14417.0 14813.6 14972.9 14149.2 14207.9 14890.6 14895.9 15534.4 11498.6 11613.7 11669.3 11870.8 12064.8 10955.8 10963.0 12137.3 12148.1 12175.3 08:06:56 INFO - PROCESS | 7659 | -------- Summary: end -------- 08:06:56 INFO - PROCESS | 7659 | 08:06:56 INFO - TEST-INFO | 7659: exit 0 08:06:56 INFO - TEST-OK | dromaeo_css | took 1112378ms 08:06:56 INFO - TEST-START | kraken 08:06:56 INFO - operating with platform_type : linux_ 08:06:56 INFO - Initialising browser for kraken test... 08:06:56 INFO - TEST-INFO | started process 7902 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRKXseP/profile http://localhost:46949/getInfo.html) 08:07:01 INFO - PROCESS | 7902 | __metrics Screen width/height:1600/1200 08:07:01 INFO - PROCESS | 7902 | colorDepth:24 08:07:01 INFO - PROCESS | 7902 | Browser inner width/height: 1024/697 08:07:01 INFO - PROCESS | 7902 | __metrics 08:07:02 ERROR - PROCESS | 7902 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 08:07:02 INFO - TEST-INFO | 7902: exit 0 08:07:02 INFO - Browser initialized. 08:07:02 INFO - Running cycle 1/1 for kraken test... 08:07:02 INFO - TEST-INFO | started process 8020 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRKXseP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:07:14 INFO - PROCESS | 8020 | RSS: Main: 162729984 08:07:14 INFO - PROCESS | 8020 | 08:07:17 INFO - PROCESS | 8020 | Cycle 1(1): loaded http://localhost:46949/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46949/tests/kraken/driver.html?testName=audio-beat-detection) 08:07:18 INFO - PROCESS | 8020 | RSS: Main: 168255488 08:07:18 INFO - PROCESS | 8020 | 08:07:20 INFO - PROCESS | 8020 | Cycle 1(1): loaded http://localhost:46949/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46949/tests/kraken/driver.html?testName=audio-dft) 08:07:21 INFO - PROCESS | 8020 | RSS: Main: 167198720 08:07:21 INFO - PROCESS | 8020 | 08:07:24 INFO - PROCESS | 8020 | Cycle 1(1): loaded http://localhost:46949/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46949/tests/kraken/driver.html?testName=audio-fft) 08:07:24 INFO - PROCESS | 8020 | RSS: Main: 163500032 08:07:24 INFO - PROCESS | 8020 | 08:07:27 INFO - PROCESS | 8020 | Cycle 1(1): loaded http://localhost:46949/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46949/tests/kraken/driver.html?testName=audio-oscillator) 08:07:27 INFO - PROCESS | 8020 | RSS: Main: 164438016 08:07:27 INFO - PROCESS | 8020 | 08:07:29 INFO - PROCESS | 8020 | Cycle 1(1): loaded http://localhost:46949/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46949/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:07:30 INFO - PROCESS | 8020 | RSS: Main: 165015552 08:07:30 INFO - PROCESS | 8020 | 08:07:33 INFO - PROCESS | 8020 | Cycle 1(1): loaded http://localhost:46949/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46949/tests/kraken/driver.html?testName=imaging-darkroom) 08:07:34 INFO - PROCESS | 8020 | RSS: Main: 164040704 08:07:34 INFO - PROCESS | 8020 | 08:07:37 INFO - PROCESS | 8020 | Cycle 1(1): loaded http://localhost:46949/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46949/tests/kraken/driver.html?testName=imaging-desaturate) 08:07:38 INFO - PROCESS | 8020 | RSS: Main: 163090432 08:07:38 INFO - PROCESS | 8020 | 08:07:41 INFO - PROCESS | 8020 | Cycle 1(1): loaded http://localhost:46949/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46949/tests/kraken/driver.html?testName=json-parse-financial) 08:07:41 INFO - PROCESS | 8020 | RSS: Main: 164462592 08:07:41 INFO - PROCESS | 8020 | 08:07:43 INFO - PROCESS | 8020 | Cycle 1(1): loaded http://localhost:46949/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46949/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:07:44 INFO - PROCESS | 8020 | RSS: Main: 164540416 08:07:44 INFO - PROCESS | 8020 | 08:07:45 INFO - PROCESS | 8020 | Cycle 1(1): loaded http://localhost:46949/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46949/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:07:46 INFO - PROCESS | 8020 | RSS: Main: 164962304 08:07:46 INFO - PROCESS | 8020 | 08:07:48 INFO - PROCESS | 8020 | Cycle 1(1): loaded http://localhost:46949/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46949/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:07:49 INFO - PROCESS | 8020 | RSS: Main: 165355520 08:07:49 INFO - PROCESS | 8020 | 08:07:51 INFO - PROCESS | 8020 | Cycle 1(1): loaded http://localhost:46949/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46949/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:07:52 INFO - PROCESS | 8020 | RSS: Main: 165318656 08:07:52 INFO - PROCESS | 8020 | 08:07:55 INFO - PROCESS | 8020 | Cycle 1(1): loaded http://localhost:46949/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46949/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:07:55 INFO - PROCESS | 8020 | RSS: Main: 165412864 08:07:55 INFO - PROCESS | 8020 | 08:07:57 INFO - PROCESS | 8020 | Cycle 1(1): loaded http://localhost:46949/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46949/tests/kraken/driver.html?testName=ai-astar) 08:07:57 INFO - PROCESS | 8020 | RSS: Main: 166342656 08:07:57 INFO - PROCESS | 8020 | 08:07:57 INFO - PROCESS | 8020 | __start_tp_report 08:07:57 INFO - PROCESS | 8020 | _x_x_mozilla_page_load 08:07:57 INFO - PROCESS | 8020 | _x_x_mozilla_page_load_details 08:07:57 INFO - PROCESS | 8020 | |i|pagename|runs| 08:07:57 INFO - PROCESS | 8020 | |0;ai-astar;102;114;105;111;111;111;112;111;112;111 08:07:57 INFO - PROCESS | 8020 | |1;audio-beat-detection;152;119;144;175;124;146;157;119;197;120 08:07:57 INFO - PROCESS | 8020 | |2;audio-dft;162;162;164;161;164;164;176;162;162;161 08:07:57 INFO - PROCESS | 8020 | |3;audio-fft;75;75;74;195;75;75;76;98;170;76 08:07:57 INFO - PROCESS | 8020 | |4;audio-oscillator;83;82;156;83;83;83;135;83;83;147 08:07:57 INFO - PROCESS | 8020 | |5;imaging-gaussian-blur;118;118;117;117;117;118;118;117;118;117 08:07:57 INFO - PROCESS | 8020 | |6;imaging-darkroom;146;146;147;148;147;147;147;146;149;147 08:07:57 INFO - PROCESS | 8020 | |7;imaging-desaturate;95;97;95;96;95;96;95;95;95;96 08:07:57 INFO - PROCESS | 8020 | |8;json-parse-financial;55;54;52;52;53;55;54;52;52;52 08:07:57 INFO - PROCESS | 8020 | |9;json-stringify-tinderbox;60;61;61;62;65;61;61;61;61;62 08:07:57 INFO - PROCESS | 8020 | |10;stanford-crypto-aes;77;81;82;89;77;77;76;77;91;80 08:07:57 INFO - PROCESS | 8020 | |11;stanford-crypto-ccm;126;125;131;125;135;124;135;122;171;125 08:07:57 INFO - PROCESS | 8020 | |12;stanford-crypto-pbkdf2;169;159;161;158;157;162;161;158;157;160 08:07:57 INFO - PROCESS | 8020 | |13;stanford-crypto-sha256-iterative;72;64;64;65;69;63;64;63;63;69 08:07:57 INFO - PROCESS | 8020 | __end_tp_report 08:07:57 INFO - PROCESS | 8020 | __start_cc_report 08:07:57 INFO - PROCESS | 8020 | _x_x_mozilla_cycle_collect,860 08:07:57 INFO - PROCESS | 8020 | __end_cc_report 08:07:57 INFO - PROCESS | 8020 | __startTimestamp1470150477781__endTimestamp 08:07:57 INFO - PROCESS | 8020 | 08:07:57 INFO - PROCESS | 8020 | ------- Summary: start ------- 08:07:57 INFO - PROCESS | 8020 | Number of tests: 14 08:07:57 INFO - PROCESS | 8020 | 08:07:57 INFO - PROCESS | 8020 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:3.62 (3.3%) stddev-sans-first:2.42 08:07:57 INFO - PROCESS | 8020 | Values: 102.0 114.0 105.0 111.0 111.0 111.0 112.0 111.0 112.0 111.0 08:07:57 INFO - PROCESS | 8020 | 08:07:57 INFO - PROCESS | 8020 | [#1] audio-beat-detection Cycles:10 Average:145.30 Median:149.00 stddev:26.28 (17.6%) stddev-sans-first:27.76 08:07:57 INFO - PROCESS | 8020 | Values: 152.0 119.0 144.0 175.0 124.0 146.0 157.0 119.0 197.0 120.0 08:07:57 INFO - PROCESS | 8020 | 08:07:57 INFO - PROCESS | 8020 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.00 stddev:4.44 (2.7%) stddev-sans-first:4.66 08:07:57 INFO - PROCESS | 8020 | Values: 162.0 162.0 164.0 161.0 164.0 164.0 176.0 162.0 162.0 161.0 08:07:57 INFO - PROCESS | 8020 | 08:07:57 INFO - PROCESS | 8020 | [#3] audio-fft Cycles:10 Average:98.90 Median:75.00 stddev:45.02 (60.0%) stddev-sans-first:46.92 08:07:57 INFO - PROCESS | 8020 | Values: 75.0 75.0 74.0 195.0 75.0 75.0 76.0 98.0 170.0 76.0 08:07:57 INFO - PROCESS | 8020 | 08:07:57 INFO - PROCESS | 8020 | [#4] audio-oscillator Cycles:10 Average:101.80 Median:83.00 stddev:30.90 (37.2%) stddev-sans-first:32.02 08:07:57 INFO - PROCESS | 8020 | Values: 83.0 82.0 156.0 83.0 83.0 83.0 135.0 83.0 83.0 147.0 08:07:57 INFO - PROCESS | 8020 | 08:07:57 INFO - PROCESS | 8020 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 08:07:57 INFO - PROCESS | 8020 | Values: 118.0 118.0 117.0 117.0 117.0 118.0 118.0 117.0 118.0 117.0 08:07:57 INFO - PROCESS | 8020 | 08:07:57 INFO - PROCESS | 8020 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.94 (0.6%) stddev-sans-first:0.93 08:07:57 INFO - PROCESS | 8020 | Values: 146.0 146.0 147.0 148.0 147.0 147.0 147.0 146.0 149.0 147.0 08:07:57 INFO - PROCESS | 8020 | 08:07:57 INFO - PROCESS | 8020 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 08:07:57 INFO - PROCESS | 8020 | Values: 95.0 97.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 96.0 08:07:57 INFO - PROCESS | 8020 | 08:07:57 INFO - PROCESS | 8020 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:53.50 stddev:1.29 (2.4%) stddev-sans-first:1.17 08:07:57 INFO - PROCESS | 8020 | Values: 55.0 54.0 52.0 52.0 53.0 55.0 54.0 52.0 52.0 52.0 08:07:57 INFO - PROCESS | 8020 | 08:07:57 INFO - PROCESS | 8020 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:61.00 stddev:1.35 (2.2%) stddev-sans-first:1.32 08:07:57 INFO - PROCESS | 8020 | Values: 60.0 61.0 61.0 62.0 65.0 61.0 61.0 61.0 61.0 62.0 08:07:57 INFO - PROCESS | 8020 | 08:07:57 INFO - PROCESS | 8020 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:80.50 stddev:5.31 (6.6%) stddev-sans-first:5.46 08:07:57 INFO - PROCESS | 8020 | Values: 77.0 81.0 82.0 89.0 77.0 77.0 76.0 77.0 91.0 80.0 08:07:57 INFO - PROCESS | 8020 | 08:07:57 INFO - PROCESS | 8020 | [#11] stanford-crypto-ccm Cycles:10 Average:131.90 Median:128.50 stddev:14.48 (11.3%) stddev-sans-first:15.20 08:07:57 INFO - PROCESS | 8020 | Values: 126.0 125.0 131.0 125.0 135.0 124.0 135.0 122.0 171.0 125.0 08:07:57 INFO - PROCESS | 8020 | 08:07:57 INFO - PROCESS | 8020 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.20 Median:160.50 stddev:3.55 (2.2%) stddev-sans-first:1.86 08:07:57 INFO - PROCESS | 8020 | Values: 169.0 159.0 161.0 158.0 157.0 162.0 161.0 158.0 157.0 160.0 08:07:57 INFO - PROCESS | 8020 | 08:07:57 INFO - PROCESS | 8020 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:64.50 stddev:3.20 (5.0%) stddev-sans-first:2.42 08:07:57 INFO - PROCESS | 8020 | Values: 72.0 64.0 64.0 65.0 69.0 63.0 64.0 63.0 63.0 69.0 08:07:57 INFO - PROCESS | 8020 | -------- Summary: end -------- 08:07:57 INFO - PROCESS | 8020 | 08:07:58 INFO - TEST-INFO | 8020: exit 0 08:07:58 INFO - TEST-OK | kraken | took 61870ms 08:07:58 INFO - SUITE-END | took 1174s 08:07:58 INFO - Completed test suite (00:19:34) 08:07:58 INFO - javascript benchmark 08:07:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7407.579711698302, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3103.5344698295253, 3119.0, 3151.2279491524578, 3155.1007962730628, 3157.1002264354647, 5351.678899266047, 5377.139657654776, 5448.536874365679, 5463.78144874205, 5513.6140470167, 5404.32445944257, 5409.053415652264, 5416.891662166754, 5473.397926228112, 5491.478309560595, 4859.902801943959, 4898.608111351093, 4956.826511072113, 4975.402951645808, 4978.452370239271, 4936.111499930011, 4949.579285760715, 5107.361579802525, 5107.948920510785, 5125.692458452486, 4896.314515967767, 4980.0, 4997.950020499821, 5082.517160869711, 5105.693658380509, 4910.091633047862, 4932.457429682732, 4941.0, 4947.554720075211, 5000.249962505617, 4902.950970490321, 4903.239997800347, 4910.238912968495, 4924.359833221694, 4970.925436118461, 5356.946430535684, 5389.0569150398915, 5398.514133727944, 5400.756965936543, 5421.620486565942, 5776.133579963039, 5785.132230165466, 5788.0739081746715, 5825.038868586678, 5837.095250236178, 5822.708864556797, 5842.152887831283, 5849.941500584982, 5856.092305692625, 5856.180134781134, 5337.119375303109, 5356.678599284017, 5369.355677318707, 5400.864978375533, 5402.486763757476, 5909.734061967221, 5914.053751399755, 5921.585489015728, 5958.493528050164, 5976.402359763989, 5671.574631902624, 5679.034564124109, 5680.062789639664, 5680.318361796611, 5683.630564013326, 5620.0, 5730.656160630376, 5734.139879018181, 5773.451522105393, 5838.737256823453, 5659.830205093854, 5832.708364581838, 5836.533077353802, 5849.298084229919, 5883.058710606282, 5760.395158508296, 5784.623999440023, 5816.970915145397, 5843.3864444233595, 5875.500582450454, 4465.173942820588, 4468.687191896601, 4470.6870519064005, 4471.19518486669, 4512.571305726016, 3937.5274967004143, 3974.364101743707, 3975.1254723960683, 4006.899827504336, 4048.2308361411237, 5486.286782718221, 5649.830505084854, 5660.2075709400715, 5660.2075709400715, 5663.971680141655, 5925.525957923356, 5926.051831706906, 5937.524998000236, 5939.910901336483, 5940.079287710412, 5489.64317319373, 5555.638883472561, 5581.525570326487, 5581.553475721932, 5681.914771278434, 5069.8732531687, 5072.9854029193575, 5076.796928122908, 5078.21287700407, 5078.7460626968505, 6023.397660233942, 6094.177286066413, 6097.664628445478, 6100.572959892765, 6112.8777424452155, 5693.202951586864, 5865.501432378295, 5911.0, 5926.851828704317, 5928.49607783326, 6026.186464827192, 6033.78881739137, 6037.305709843425, 6040.7583696651645, 6074.574779765374, 5645.971770141123, 5689.715514224355, 5699.116636921284, 5735.54115670737, 5736.598438109292, 5725.570582206268, 5833.854153646193, 5866.032104702847, 5884.617499862496, 5913.467787898938, 5715.514181294637, 5721.542276617777, 5754.309482862083, 5755.050416681368, 5756.856078598069, 5696.458836410535, 5708.600397972102, 5716.771329146954, 5738.483536481736, 5746.367899530965, 5559.749811258423, 5615.241942337732, 5681.17622944679, 5690.914636280542, 5709.68596727184, 5746.195532625519, 5756.798512052058, 5783.768649253982, 5797.536197104306, 5802.448767367094, 5475.534579560782, 5635.380108188178, 5664.0937450007805, 5665.150227465749, 5665.433456654301], "value": 5382.160302659044, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.3796699564471, 583.941605839416, 587.4008511318456, 593.2910172344051, 609.7225762278164, 39995.80002099989, 44057.11885762283, 44253.55746442539, 44273.55726442735, 44288.0, 43088.56911430885, 43637.7818110909, 43749.78125109378, 43906.0, 44009.55990440094, 8801.515916624583, 8890.066543012988, 8899.599518021705, 8915.465072095663, 8915.509646969414, 8853.335999800009, 8887.244584210317, 8898.644054237822, 8906.242969347613, 8906.33202509811, 8951.462912225288, 8990.505522196276, 9003.054679258681, 9027.097290270953, 9036.68371606994, 8923.0, 8925.55372231389, 8964.058773828752, 8968.103189681045, 8995.685151019716, 8769.429987050822, 8832.955835220848, 8835.249003834682, 8845.071267516947, 8888.466691998501, 41606.1678766426, 41978.58021419777, 41992.790036049926, 42049.0, 42089.31642734287, 3224.532442795805, 3589.4053528656136, 3593.9101522462147, 3617.1318883468043, 3668.1196512836996, 28889.963651956255, 30932.226694332596, 31005.0, 31139.688603113904, 31332.37335253305, 4303.31147016479, 4327.2643650579475, 4327.939654784598, 4346.717463364871, 4425.867223983286, 303844.4807775969, 303850.0, 304748.0, 305970.0, 306034.0, 35705.82147089248, 35785.0, 35843.4623480648, 35874.0, 35970.46044309285, 36831.4475282871, 37090.814545927096, 37340.813295933345, 37930.0, 37987.620123798406, 15492.690146197014, 15932.044077355396, 15998.200089995686, 16007.759883601755, 16012.119333436773, 12101.15291929574, 12107.334096624594, 12112.636620901387, 12160.574379896661, 12201.08491863096, 19511.219551218077, 19546.200791429, 19550.770336074012, 19602.509937251398, 19616.60766784656, 7114.857702845914, 7161.641917904188, 7267.418606511466, 7281.890771638429, 7364.77905662831, 1000.3797645459862, 1077.3535878472853, 1120.8935151160626, 1138.772245550893, 1141.6860363399965, 32594.0, 32743.50884736731, 33151.83424082864, 33277.16807079794, 33391.49563782726, 1117.580907159815, 1129.181343525937, 1138.4023387721347, 1202.2185579373477, 1204.0909113619161, 17236.82763172352, 17440.563985900455, 17512.299508019536, 17512.737308940123, 17610.559736006704, 561728.0, 562722.0, 564424.1778791161, 565328.0, 566984.0, 58693.70653146707, 59224.703876480344, 59431.0, 59525.0, 59584.70207648934, 1338.6184937292826, 1353.9458421663023, 1381.0746799644262, 1388.5973067810423, 1390.4994202087241, 30168.396632066797, 30917.536236956912, 31724.206894827814, 31954.041378758673, 32174.0, 51825.22262165995, 52099.21851172311, 52411.73794131005, 52531.21203181879, 52616.47383526269, 439831.0, 439971.0, 441428.0, 441796.0, 444503.0, 29368.706312936596, 29421.55867661944, 29575.0, 29714.851425742734, 29906.0, 48277.5172248273, 48528.0, 48607.27089093737, 50236.995260095326, 50360.748196258784, 40047.799761001006, 42783.572164279205, 42923.0, 42953.3556996639, 43201.0, 40418.59581404148, 41873.0, 42195.57804421917, 42565.0, 42778.35832462453, 36242.27515449729, 41290.79354603208, 42047.15905681808, 43625.78187109171, 43702.344464832415, 34783.82608086943, 37586.43620345752, 38396.808015959745, 38536.6146338533, 38944.0, 28657.570136448387, 28696.426071478036, 29074.418511630072, 29098.27254318659, 29191.416171676025], "value": 19696.384541602383, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.1590081325152, 392.5564112552815, 404.30661415672125, 407.56797794338, 415.6155556110597, 18757.71863422048, 19573.0, 19949.401517954448, 20209.292674756387, 20239.797602023995, 15881.126538040404, 16115.194240287969, 17856.553586160353, 20076.498087547818, 20229.696554551658, 5617.578681598897, 5631.465010823976, 5652.660840349572, 5701.942980570183, 5812.244408226925, 5587.329520457531, 5606.131049687305, 5752.223449834281, 5753.712314384285, 5754.16564598133, 5524.1989911462815, 5591.189277554752, 5650.124230744241, 5714.657120572758, 5720.485156335929, 5628.690422026807, 5636.577256705764, 5662.348829884575, 5669.886602267973, 5687.601867869251, 5078.13671675816, 5096.337476128079, 5127.948720512784, 5137.357830271216, 5140.588752899759, 23425.297241082793, 23779.524409511887, 24120.517589648283, 24399.146029888867, 24552.508949821084, 2277.6583512473094, 2299.586074506588, 2341.7658234176615, 2377.1442280778906, 2428.1258746851117, 14889.776653350209, 15145.318460669187, 15336.769948450783, 15460.149691766948, 15924.681506369923, 1989.801019898013, 1993.401979406187, 2012.4868158619604, 2024.2813801100692, 2058.166442590753, 80423.5978820108, 80429.59785201037, 81499.0, 82922.0, 83936.0, 10409.167266618653, 10648.574057037787, 11053.447327633587, 11890.10824188172, 12038.638840834614, 15371.846281537042, 15385.230738463031, 15414.691706165813, 15431.84568154304, 15440.922795386175, 7797.259260370256, 8062.153473885158, 8072.878906816402, 8265.710700125586, 8278.71024514139, 7592.392608591299, 7673.194314596999, 7934.920650793533, 7955.880661790078, 7963.203679631991, 6499.707513161919, 6682.231543372574, 6730.192376914802, 6763.695633696496, 6822.249552549315, 1913.9330123445613, 1940.5827747034455, 1947.0, 1994.5811379610154, 1997.6304383689064, 943.6602822983721, 944.0182210501002, 1007.450939238117, 1047.7904419116207, 1064.5316060933164, 19711.704324435144, 20816.47958801012, 20887.68668469974, 20898.895505522374, 20936.0, 1033.1373303291684, 1044.3785947361307, 1052.6421016854306, 1085.2457542008228, 1088.3198001249218, 11368.94315528417, 11589.27859705072, 11816.35010074437, 11899.16705830601, 11947.402629868471, 487607.0, 491836.0, 494522.0, 509500.0, 518446.0, 80742.19257807346, 82747.0, 83497.58251208706, 83771.0, 86451.56774216089, 985.393982700634, 1049.9895001050045, 1062.7502536903821, 1069.2942657845786, 1069.5828626835541, 14893.404263829325, 16314.592135196715, 17700.380486682905, 18535.35126270574, 18749.34377296788, 43068.56931430771, 43784.0, 45108.0, 45141.0, 45585.316220256056, 61397.0, 62484.68757656364, 63386.0, 63777.681111596, 65107.0, 8235.752927412188, 8329.95835020821, 8472.44929079608, 8541.87187192205, 8575.742727718178, 12182.0, 12982.80525792095, 13002.154859934075, 13095.672608184872, 13236.669083272995, 11289.435528223392, 11368.886311137114, 11484.425778711198, 11754.941225293818, 12141.817872732092, 11354.54581816718, 11488.770224595628, 11574.479148438171, 11640.94179529097, 12000.03999680006, 11429.828552571551, 11462.197646164688, 11574.421278935852, 11645.941770291094, 12095.57665481704, 8162.959410036411, 8222.83554328898, 8430.241278284984, 8455.0, 8617.784555386166, 10313.690589282334, 11042.723931901446, 11069.944650276697, 11401.20191586581, 11686.824697629372], "value": 9459.206048878736, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1480.740870347689, 1487.4942519543356, 1641.1466037660416, 1744.9825501744979, 1768.9027103509302, 8008.95995520023, 8573.228409443149, 8681.21869031787, 9382.71851844445, 9402.106799854002, 8670.263027642657, 8911.955440222806, 8963.596638151283, 8965.0, 8970.50662213578, 2315.722113346401, 2347.6830627865274, 2355.187460326185, 2369.8815059247054, 2372.774586414288, 2227.1091563374616, 2284.748677645466, 2304.942376440594, 2307.4231442139467, 2307.61924282494, 2302.3898666853297, 2318.597248664559, 2325.651152327156, 2342.3441436397834, 2345.2026311054237, 2298.482841360697, 2309.988450057756, 2312.722473303206, 2312.8612283262974, 2341.2390972933695, 2294.4263934016494, 2305.7348404933477, 2306.5386922615544, 2306.757790432014, 2307.526956973833, 9214.723558293263, 9249.075092490697, 9288.674896378594, 9294.581743821544, 9321.953390233073, 5394.81314110895, 5462.180672899057, 5522.3649280332875, 5528.44715528448, 5538.418466061086, 3420.3672320620763, 3431.2892814676375, 3547.5565554305713, 3591.730620203495, 3681.245344704329, 1142.5144313666658, 1191.255465334166, 1195.1275568834712, 1207.643745095199, 1214.769193853165, 12929.741405171844, 13016.349182540835, 13102.80345794814, 13103.541376051793, 13141.40863661128, 4677.0871198352115, 4738.431388233434, 4762.999770048329, 4858.02839432115, 4894.070126675921, 10910.836337454944, 11003.889961100447, 11004.119670426348, 11010.889891101147, 11012.559497620005, 5472.425395333512, 5494.0, 5508.03609368359, 5515.062439385234, 5530.225768392428, 4455.866324010285, 4938.9012219755405, 4979.6265280104135, 5004.274380214922, 5066.0, 4092.6660183038066, 4140.937885931713, 4170.895727606834, 4185.991081803134, 4209.852655157055, 1331.1347624044256, 1339.3504150487006, 1342.8657134286689, 1356.504875720355, 1365.5493687083438, 841.2386789955101, 867.7743786615399, 999.6201443451442, 1001.4692213127055, 1007.8460163113194, 5844.795432159854, 6340.682965851689, 6488.416042556099, 6537.248216455074, 6562.179727534059, 955.412421360858, 1008.1078245752561, 1027.5889644142403, 1035.3477309295097, 1052.1740433759462, 4274.380214868826, 4371.803268852909, 4392.648588112943, 4407.0524837160165, 4409.933850992237, 11393.943030284796, 11533.192676512563, 11556.364399958084, 11578.247413918069, 11612.88387116118, 11597.072234221241, 11619.825702614467, 11646.359450230319, 11651.941740291413, 11674.182807203584, 7988.440809143304, 8260.917390826135, 8262.545559994138, 8434.536100514408, 8645.956770216235, 6121.602095863755, 6167.6916154193, 6212.161358216764, 6238.282597501164, 6337.714802833976, 10644.627438039632, 10707.94646026796, 10797.838032429363, 10845.891541084804, 10932.508037138188, 10663.253572250178, 10841.0, 10880.292780969212, 10923.726906827393, 10936.835947460953, 7414.369778568882, 8088.83822323562, 8170.7957301067945, 8186.222308880647, 8360.707375241838, 9092.318076144184, 9162.175404213653, 9168.129027742354, 9169.35814492979, 9175.449473031373, 7921.722739704082, 8045.9597702011115, 8053.154418785943, 8285.585720714062, 8326.791830204293, 7801.2198780121535, 7828.373730101464, 7862.1351651319455, 7947.920520794718, 8031.116577176389, 7205.891911621435, 7264.0, 7318.121825380988, 7348.595827229554, 7354.669039893324, 5467.289252397163, 5504.779808807763, 5532.778688852401, 5579.521426821814, 5808.07070868659, 5466.781328746964, 5503.0, 5596.468335508121, 5640.633358831663, 5643.604947653789], "value": 4835.943742350461, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.9983750081249, 325.7980052367532, 333.2202645808808, 335.99832000840007, 337.7061956098195, 5551.639143455673, 5609.411011843759, 5610.775568977241, 5625.831225063244, 5645.5483561315095, 5521.668699878011, 5552.278203833496, 5561.972190139044, 5590.161475778636, 5616.550675945925, 4144.70987030908, 4145.170965806836, 4250.9149817003645, 4281.544274946517, 4307.1170410066015, 4280.6361459275995, 4288.399624052635, 4292.892677683051, 4305.892352691177, 4340.242201908232, 4231.894202644943, 4256.87229383119, 4263.87208383749, 4267.978660106711, 4271.700980931336, 4007.9198416031663, 4184.497860256758, 4221.403836640475, 4224.091820258628, 4271.209826182151, 3657.3051120287328, 3658.70730341572, 3674.5223120994365, 3705.8702945397054, 3711.480392745018, 5462.235287059775, 5496.890062198773, 5498.725063746837, 5506.229127922094, 5513.228148059275, 4662.440507139131, 4905.607551395879, 4909.754512274372, 4920.237363208708, 4965.255211718235, 5784.710764461802, 5821.53427725781, 5822.184894114827, 5860.443257890493, 5869.325027621793, 4077.245709543744, 4083.9387409188885, 4105.158442519306, 4113.568075352075, 4131.29767939451, 5888.146218798293, 6029.366916473751, 6039.8188054358, 6040.335563088057, 6099.420555047263, 4193.1404062167185, 4216.768077755692, 4223.092035212444, 4223.619874211336, 4240.660747140221, 4278.657707383401, 4280.5291417944, 4288.24955632763, 4295.269804133305, 4298.290782020931, 4612.377329060534, 4824.8793780155775, 4885.364902562644, 4938.802447902043, 4967.205247160437, 5799.652020878761, 5821.7380217890295, 5822.272215973004, 5827.0, 5857.853553661107, 1496.518446737722, 1517.9392824287127, 1518.4381778741936, 1521.7445607373961, 1524.0322395279077, 936.6159874451579, 978.3640633588083, 989.8122253296074, 993.2997236947934, 1016.9745756356002, 5615.859603509945, 5630.155476678449, 5642.4357564244065, 5653.830385088454, 5661.631993920382, 5923.437273459014, 5958.910616340759, 5973.761049558056, 6004.819855404345, 6017.2779266488305, 5328.17413300939, 5650.74571644277, 5656.490915817596, 5698.430156984351, 5716.828495145152, 3174.587303650511, 3189.3734195560432, 3214.5017522284083, 3214.9678503215137, 3225.951610725841, 6136.668066134929, 6141.447269745744, 6173.41352571505, 6297.842553936188, 6300.684965751694, 6116.48009919153, 6122.204113465221, 6130.877382452326, 6138.78514252008, 6148.44663980244, 6098.35967223444, 6256.405641464054, 6259.6870156492, 6261.906071408933, 6283.748650054038, 5891.823245302648, 5949.2266005419015, 5969.432903874125, 5988.311344195299, 5996.400359963969, 5933.647489168606, 5956.463918247378, 5957.225560677084, 5978.551608629457, 5998.940010599838, 6018.398160183947, 6130.601510901777, 6164.291106522807, 6220.626762394271, 6238.656873871981, 4134.834606615702, 4177.561356057692, 4181.958180418157, 4198.99224186187, 4202.4326715894185, 5769.509591684754, 6001.189839371804, 6046.606970546901, 6050.03373903492, 6053.757849685963, 5765.279340082489, 5811.331696854916, 5813.622114562709, 5829.446202610745, 5880.647161170173, 5797.4782269595935, 5816.680082595498, 5823.621464604787, 5829.125631155361, 5873.970630146822, 5563.221149039056, 5697.715114244188, 5759.856003599776, 5771.797987070432, 5775.6823374714795, 5774.220480235114, 5810.477057064884, 5821.952048631287, 5822.689894773812, 5843.386444423274, 5633.492985631313, 5705.686187259575, 5719.370869204301, 5750.568707346882, 5759.716961332], "value": 4428.363189326105, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [746.6229554075189, 757.212499001039, 770.456827936305, 789.0964845252187, 800.7637746864674, 16012.519624411272, 17279.481615551522, 17294.91352543239, 17331.046792426412, 17350.913245433785, 15590.45433409831, 16014.279357428915, 16163.191840407962, 16696.66606667866, 16773.83226167738, 796.8047828282065, 818.9017317921857, 824.3775949158377, 826.7065191856894, 826.904905935816, 793.0562630469751, 804.0552350987596, 805.8348038652092, 816.4774544291658, 818.4475479051616, 871.7951281448854, 873.7204094689702, 875.0199776250608, 875.1248751248751, 876.408424313589, 862.107718511344, 865.03548543374, 867.249828898005, 868.2055918834259, 869.5565261716539, 628.1833616298838, 629.0469938043867, 631.0313668518802, 631.8104568629393, 633.8383712153371, 15680.451184208498, 15759.763603545956, 15832.050076995418, 15909.284082216329, 15971.440999565075, 15128.54614361571, 15355.232238388036, 15540.922295388564, 15552.844471555365, 15563.066216026962, 12763.744725105538, 12915.935420322932, 12991.415386307639, 13061.477540898353, 13630.182189068588, 3975.3043217436834, 4001.2197621463824, 4057.3305404608204, 4067.715259931806, 4154.439150714645, 85284.0, 86843.69734453988, 87428.56285718594, 88540.5572972131, 88584.0, 11366.318020918772, 11523.596674116367, 11533.826992595117, 11558.30650160993, 11592.130590205768, 21475.892620536797, 21637.35087947364, 21670.24154154597, 21737.021834017192, 21830.345089647337, 8377.45546539473, 8448.746537603882, 8450.61972211252, 8856.424332418372, 8888.511131887679, 4776.665633405698, 4874.5856602188505, 5066.290719299301, 5079.085764562415, 5220.347456567929, 3285.9835700821823, 3355.379254837863, 3375.0, 3377.8142202178624, 3404.1149301181376, 603.408659513679, 607.2439812433461, 614.883172197281, 622.8380621038563, 644.7968889799698, 577.6620676903974, 604.597942368329, 652.9706163222667, 652.9836754081091, 713.5255055388109, 9562.709034280422, 9708.514574271258, 9922.851157232648, 10066.69799906004, 10254.48727563619, 597.0655923479741, 615.2678312807744, 732.5458215906066, 736.2821249281907, 756.7237958145238, 4519.163954668331, 4815.798937147872, 4966.801327946914, 5215.47845215483, 5289.9471005290225, 72400.0, 112212.43893780479, 112494.0, 113713.0, 117021.0, 91279.54360228157, 94354.0, 94532.52733736426, 95724.0, 96006.0, 56128.43871561314, 57696.13455798166, 68246.0, 74505.62747186446, 85516.57241713752, 9894.653687120915, 9991.600335986479, 10123.949380253052, 10264.332818366782, 10429.530671119666, 48928.0, 50214.0, 50750.74624626853, 50826.49173508218, 52667.209991849384, 67849.32150678628, 72136.27863721506, 72578.0, 73489.6325518369, 73673.6316318415, 12377.690557736129, 12444.128910976146, 12498.750024999266, 12774.297413642338, 12803.167794093726, 15072.504182933386, 15493.225338733244, 15515.844841551892, 15532.999950487607, 15620.218989050274, 14735.26323683833, 14978.775318370452, 14990.400383984519, 15193.544193674208, 15799.68400631958, 13311.400986955803, 13487.865121348661, 14417.0, 14813.629659258604, 14972.861126938338, 14149.151050936976, 14207.900808818733, 14890.627734306729, 14895.92552037233, 15534.378624854879, 11498.576908798415, 11613.709657258636, 11669.299842009506, 11870.82193767077, 12064.819027714766, 10955.780884382108, 10963.0, 12137.271763694207, 12148.149629525848, 12175.269483830998], "value": 7692.978134125759, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1532.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 114.0, 105.0, 111.0, 111.0, 111.0, 112.0, 111.0, 112.0, 111.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 119.0, 144.0, 175.0, 124.0, 146.0, 157.0, 119.0, 197.0, 120.0], "value": 145.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 164.0, 161.0, 164.0, 164.0, 176.0, 162.0, 162.0, 161.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 195.0, 75.0, 75.0, 76.0, 98.0, 170.0, 76.0], "value": 98.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 156.0, 83.0, 83.0, 83.0, 135.0, 83.0, 83.0, 147.0], "value": 101.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 148.0, 147.0, 147.0, 147.0, 146.0, 149.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 52.0, 52.0, 53.0, 55.0, 54.0, 52.0, 52.0, 52.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 62.0, 65.0, 61.0, 61.0, 61.0, 61.0, 62.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 81.0, 82.0, 89.0, 77.0, 77.0, 76.0, 77.0, 91.0, 80.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 125.0, 131.0, 125.0, 135.0, 124.0, 135.0, 122.0, 171.0, 125.0], "value": 131.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 159.0, 161.0, 158.0, 157.0, 162.0, 161.0, 158.0, 157.0, 160.0], "value": 160.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 64.0, 64.0, 65.0, 69.0, 63.0, 64.0, 63.0, 63.0, 69.0], "value": 65.6, "unit": "score"}]}]} 08:07:59 INFO - Return code: 0 08:07:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:07:59 ERROR - # TBPL SUCCESS # 08:07:59 INFO - Running post-action listener: _resource_record_post_action 08:07:59 INFO - [mozharness: 2016-08-02 15:07:59.091748Z] Finished run-tests step (success) 08:07:59 INFO - Running post-run listener: _resource_record_post_run 08:07:59 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 543858688; Read time: 0; Write time: 642892 08:07:59 INFO - TinderboxPrint: CPU usage
13.3% 08:07:59 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:07:59 INFO - TinderboxPrint: I/O write bytes / time
543,858,688 / 642,892 08:07:59 INFO - TinderboxPrint: CPU idle
8,240.5 (86.6%) 08:07:59 INFO - TinderboxPrint: CPU user
1,211.8 (12.7%) 08:07:59 INFO - TinderboxPrint: Swap in / out
0 / 0 08:07:59 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 251904000; Read time: 0; Write time: 371424 08:07:59 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 291598336; Read time: 0; Write time: 271384 08:07:59 INFO - Running post-run listener: _upload_blobber_files 08:07:59 INFO - Blob upload gear active. 08:07:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:07:59 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:07:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:07:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:08:00 INFO - (blobuploader) - INFO - Open directory for files ... 08:08:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:08:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:08:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:08:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:08:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:08:00 INFO - (blobuploader) - INFO - Done attempting. 08:08:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:08:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:08:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:08:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:08:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:08:04 INFO - (blobuploader) - INFO - Done attempting. 08:08:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:08:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:08:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:08:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:08:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:08:05 INFO - (blobuploader) - INFO - Done attempting. 08:08:05 INFO - (blobuploader) - INFO - Iteration through files over. 08:08:05 INFO - Return code: 0 08:08:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:08:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:08:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ac03d78d4534b82c4e022bbb305c805c88f718fc304804d739063f25ad32b39eedaab183c19d27d821402685afc452517933be5359b905d0e5f855ac17987f77", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1580f4091deceec4320036366213fd10246ecc7f3bdab9605fa286717a3fa0d55b62b08a299c65e35c7bd2f4ac5bfb44b04cb9f32be7f3441f18e36f865804c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9cbddd0fce8881bfc4b5dde0a73766102b5fabbdfd58d76e96be8035409e5f1fc8d45bcbd3b109cac4ca28040ebd5bf6c8426ce71e9eace051fbd060ac5514af"} 08:08:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:08:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:08:05 INFO - Contents: 08:08:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ac03d78d4534b82c4e022bbb305c805c88f718fc304804d739063f25ad32b39eedaab183c19d27d821402685afc452517933be5359b905d0e5f855ac17987f77", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1580f4091deceec4320036366213fd10246ecc7f3bdab9605fa286717a3fa0d55b62b08a299c65e35c7bd2f4ac5bfb44b04cb9f32be7f3441f18e36f865804c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9cbddd0fce8881bfc4b5dde0a73766102b5fabbdfd58d76e96be8035409e5f1fc8d45bcbd3b109cac4ca28040ebd5bf6c8426ce71e9eace051fbd060ac5514af"} 08:08:05 INFO - Running post-run listener: copy_logs_to_upload_dir 08:08:05 INFO - Copying logs to upload dir... 08:08:05 INFO - mkdir: /builds/slave/test/build/upload/logs 08:08:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.075731 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-08-02 08:08:05.012074) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-02 08:08:05.017291) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1470149256.774787-359842650 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/Mozilla-Inbound/sha512/ac03d78d4534b82c4e022bbb305c805c88f718fc304804d739063f25ad32b39eedaab183c19d27d821402685afc452517933be5359b905d0e5f855ac17987f77", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1580f4091deceec4320036366213fd10246ecc7f3bdab9605fa286717a3fa0d55b62b08a299c65e35c7bd2f4ac5bfb44b04cb9f32be7f3441f18e36f865804c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9cbddd0fce8881bfc4b5dde0a73766102b5fabbdfd58d76e96be8035409e5f1fc8d45bcbd3b109cac4ca28040ebd5bf6c8426ce71e9eace051fbd060ac5514af"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470137583/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011457 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470137583/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ac03d78d4534b82c4e022bbb305c805c88f718fc304804d739063f25ad32b39eedaab183c19d27d821402685afc452517933be5359b905d0e5f855ac17987f77", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1580f4091deceec4320036366213fd10246ecc7f3bdab9605fa286717a3fa0d55b62b08a299c65e35c7bd2f4ac5bfb44b04cb9f32be7f3441f18e36f865804c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9cbddd0fce8881bfc4b5dde0a73766102b5fabbdfd58d76e96be8035409e5f1fc8d45bcbd3b109cac4ca28040ebd5bf6c8426ce71e9eace051fbd060ac5514af"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-02 08:08:05.042258) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 08:08:05.042544) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1470149256.774787-359842650 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004445 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 08:08:05.126488) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-02 08:08:05.126780) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-02 08:08:05.127061) ========= ========= Total master_lag: 0.17 =========