builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-036 starttime: 1460667314.99 results: success (0) buildid: 20160414125440 builduid: 24ccb5054ed0401098e0f89627d02d1c revision: 43d9dbd33ab796c4abb1cf973bb6c9d3d94a6e39 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 13:55:14.988118) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 13:55:14.988663) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 13:55:14.989063) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 13:55:15.009580) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 13:55:15.010049) ========= 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=14ef55db36f7623abb31b9cf000001d5-1460664761.508680-1226443325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-14 13:55:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 217M=0s 2016-04-14 13:55:15 (217 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.072393 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 13:55:15.098023) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 13:55:15.098447) ========= 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=14ef55db36f7623abb31b9cf000001d5-1460664761.508680-1226443325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016620 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 13:55:15.148659) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 13:55:15.149016) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 43d9dbd33ab796c4abb1cf973bb6c9d3d94a6e39 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 43d9dbd33ab796c4abb1cf973bb6c9d3d94a6e39 --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=14ef55db36f7623abb31b9cf000001d5-1460664761.508680-1226443325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-14 13:55:15,574 truncating revision to first 12 chars 2016-04-14 13:55:15,574 Setting DEBUG logging. 2016-04-14 13:55:15,574 attempt 1/10 2016-04-14 13:55:15,574 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/43d9dbd33ab7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-14 13:55:15,955 unpacking tar archive at: fx-team-43d9dbd33ab7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.673118 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 13:55:15.835708) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 13:55:15.836060) ========= script_repo_revision: 43d9dbd33ab796c4abb1cf973bb6c9d3d94a6e39 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 13:55:15.836639) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 13:55:15.836950) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 13:55:15.847382) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-04-14 13:55:15.847723) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1460664761.508680-1226443325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:55:16 INFO - MultiFileLogger online at 20160414 13:55:16 in /builds/slave/test 13:55:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 13:55:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:55:16 INFO - {'append_to_log': False, 13:55:16 INFO - 'base_work_dir': '/builds/slave/test', 13:55:16 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:55:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:55:16 INFO - 'branch': 'Fx-Team-Non-PGO', 13:55:16 INFO - 'buildbot_json_path': 'buildprops.json', 13:55:16 INFO - 'config_files': ('talos/linux_config.py',), 13:55:16 INFO - 'default_actions': ('clobber', 13:55:16 INFO - 'read-buildbot-config', 13:55:16 INFO - 'download-and-extract', 13:55:16 INFO - 'populate-webroot', 13:55:16 INFO - 'create-virtualenv', 13:55:16 INFO - 'install', 13:55:16 INFO - 'run-tests'), 13:55:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:55:16 INFO - 'download_minidump_stackwalk': True, 13:55:16 INFO - 'download_symbols': 'ondemand', 13:55:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:55:16 INFO - 'tooltool.py': '/tools/tooltool.py', 13:55:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:55:16 INFO - '/tools/misc-python/virtualenv.py')}, 13:55:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:55:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:55:16 INFO - 'installer_path': 'installer.exe', 13:55:16 INFO - 'log_level': 'info', 13:55:16 INFO - 'log_name': 'talos', 13:55:16 INFO - 'log_to_console': True, 13:55:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:55:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:55:16 INFO - 'opt_config_files': (), 13:55:16 INFO - 'pip_index': False, 13:55:16 INFO - 'sps_profile': False, 13:55:16 INFO - 'sps_profile_interval': 0, 13:55:16 INFO - 'suite': 'dromaeojs-e10s', 13:55:16 INFO - 'system_bits': '32', 13:55:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:55:16 INFO - 'title': 'talos-linux64-ix-036', 13:55:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:55:16 INFO - 'use_talos_json': True, 13:55:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:55:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:55:16 INFO - 'work_dir': 'build'} 13:55:16 INFO - ##### 13:55:16 INFO - ##### Running clobber step. 13:55:16 INFO - ##### 13:55:16 INFO - Running pre-action listener: _resource_record_pre_action 13:55:16 INFO - Running main action method: clobber 13:55:16 INFO - rmtree: /builds/slave/test/build 13:55:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:55:16 INFO - Running post-action listener: _resource_record_post_action 13:55:16 INFO - ##### 13:55:16 INFO - ##### Running read-buildbot-config step. 13:55:16 INFO - ##### 13:55:16 INFO - Running pre-action listener: _resource_record_pre_action 13:55:16 INFO - Running main action method: read_buildbot_config 13:55:16 INFO - Using buildbot properties: 13:55:16 INFO - { 13:55:16 INFO - "project": "", 13:55:16 INFO - "product": "firefox", 13:55:16 INFO - "script_repo_revision": "production", 13:55:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 13:55:16 INFO - "repository": "", 13:55:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 13:55:16 INFO - "buildid": "20160414125440", 13:55:16 INFO - "pgo_build": "False", 13:55:16 INFO - "basedir": "/builds/slave/test", 13:55:16 INFO - "buildnumber": 1145, 13:55:16 INFO - "slavename": "talos-linux64-ix-036", 13:55:16 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:55:16 INFO - "platform": "ubuntu64_hw", 13:55:16 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:55:16 INFO - "branch": "fx-team", 13:55:16 INFO - "repo_path": "integration/fx-team", 13:55:16 INFO - "revision": "43d9dbd33ab796c4abb1cf973bb6c9d3d94a6e39", 13:55:16 INFO - "stage_platform": "linux64", 13:55:16 INFO - "builduid": "24ccb5054ed0401098e0f89627d02d1c", 13:55:16 INFO - "slavebuilddir": "test" 13:55:16 INFO - } 13:55:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/YUAMftqOSXi4jPiCKqiqdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 13:55:16 INFO - Running post-action listener: _resource_record_post_action 13:55:16 INFO - ##### 13:55:16 INFO - ##### Running download-and-extract step. 13:55:16 INFO - ##### 13:55:16 INFO - Running pre-action listener: _resource_record_pre_action 13:55:16 INFO - Running main action method: download_and_extract 13:55:16 INFO - mkdir: /builds/slave/test/build/tests 13:55:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:55:16 INFO - https://queue.taskcluster.net/v1/task/YUAMftqOSXi4jPiCKqiqdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:55:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YUAMftqOSXi4jPiCKqiqdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 13:55:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YUAMftqOSXi4jPiCKqiqdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 13:55:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YUAMftqOSXi4jPiCKqiqdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 13:55:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YUAMftqOSXi4jPiCKqiqdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:55:17 INFO - Downloaded 1361 bytes. 13:55:17 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 13:55:17 INFO - Using the following test package requirements: 13:55:17 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 13:55:17 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:55:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:55:17 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:55:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:55:17 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:55:17 INFO - u'jsshell-linux-x86_64.zip'], 13:55:17 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:55:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:55:17 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 13:55:17 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:55:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:55:17 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:55:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:55:17 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:55:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:55:17 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:55:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:55:17 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:55:17 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')]} 13:55:17 INFO - https://queue.taskcluster.net/v1/task/YUAMftqOSXi4jPiCKqiqdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:55:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YUAMftqOSXi4jPiCKqiqdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:55:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YUAMftqOSXi4jPiCKqiqdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:55:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YUAMftqOSXi4jPiCKqiqdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:55:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YUAMftqOSXi4jPiCKqiqdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:55:19 INFO - Downloaded 22202881 bytes. 13:55:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:55:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:55:20 INFO - Return code: 0 13:55:20 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:55:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:55:20 INFO - https://queue.taskcluster.net/v1/task/YUAMftqOSXi4jPiCKqiqdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:55:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YUAMftqOSXi4jPiCKqiqdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:55:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YUAMftqOSXi4jPiCKqiqdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:55:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YUAMftqOSXi4jPiCKqiqdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:55:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YUAMftqOSXi4jPiCKqiqdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:55:35 INFO - Downloaded 22202881 bytes. 13:55:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:55:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:55:36 INFO - Return code: 0 13:55:36 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')]} 13:55:36 INFO - https://queue.taskcluster.net/v1/task/YUAMftqOSXi4jPiCKqiqdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:55:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YUAMftqOSXi4jPiCKqiqdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 13:55:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YUAMftqOSXi4jPiCKqiqdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 13:55:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YUAMftqOSXi4jPiCKqiqdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 13:55:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YUAMftqOSXi4jPiCKqiqdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:55:39 INFO - Downloaded 10841076 bytes. 13:55:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:55:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:55:39 INFO - Return code: 0 13:55: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')]} 13:55:39 INFO - https://queue.taskcluster.net/v1/task/YUAMftqOSXi4jPiCKqiqdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:55:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YUAMftqOSXi4jPiCKqiqdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:55:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YUAMftqOSXi4jPiCKqiqdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:55:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YUAMftqOSXi4jPiCKqiqdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:55:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YUAMftqOSXi4jPiCKqiqdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:55:40 INFO - Downloaded 54452565 bytes. 13:55:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YUAMftqOSXi4jPiCKqiqdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:55:40 INFO - mkdir: /builds/slave/test/properties 13:55:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:55:40 INFO - Writing to file /builds/slave/test/properties/build_url 13:55:40 INFO - Contents: 13:55:40 INFO - build_url:https://queue.taskcluster.net/v1/task/YUAMftqOSXi4jPiCKqiqdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:55:41 INFO - Running post-action listener: _resource_record_post_action 13:55:41 INFO - Running post-action listener: set_extra_try_arguments 13:55:41 INFO - ##### 13:55:41 INFO - ##### Running populate-webroot step. 13:55:41 INFO - ##### 13:55:41 INFO - Running pre-action listener: _resource_record_pre_action 13:55:41 INFO - Running main action method: populate_webroot 13:55:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:55:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:55:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:55:41 INFO - '--tppagecycles', 13:55:41 INFO - '7'], 13:55:41 INFO - 'tests': ['tsvgm']}}, 13:55:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:55:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:55:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:55:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:55:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:55:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:55:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:41 INFO - 'talos_options': ['--disable-e10s'], 13:55:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:55:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:55:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:41 INFO - 'talos_options': ['--disable-e10s'], 13:55:41 INFO - 'tests': ['damp', 'tps']}, 13:55:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:41 INFO - 'tests': ['damp', 'tps']}, 13:55:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:55:41 INFO - 'tests': ['dromaeo_dom']}, 13:55:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:55:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:55:41 INFO - 'tests': ['a11yr', 13:55:41 INFO - 'ts_paint', 13:55:41 INFO - 'tpaint', 13:55:41 INFO - 'sessionrestore', 13:55:41 INFO - 'sessionrestore_no_auto_restore', 13:55:41 INFO - 'tabpaint']}, 13:55:41 INFO - 'other-e10s': {'tests': ['a11yr', 13:55:41 INFO - 'ts_paint', 13:55:41 INFO - 'tpaint', 13:55:41 INFO - 'sessionrestore', 13:55:41 INFO - 'sessionrestore_no_auto_restore', 13:55:41 INFO - 'tabpaint']}, 13:55:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:55:41 INFO - 'ts_paint', 13:55:41 INFO - 'tpaint', 13:55:41 INFO - 'sessionrestore', 13:55:41 INFO - 'sessionrestore_no_auto_restore', 13:55:41 INFO - 'tabpaint']}, 13:55:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:55:41 INFO - 'ts_paint', 13:55:41 INFO - 'tpaint', 13:55:41 INFO - 'sessionrestore', 13:55:41 INFO - 'sessionrestore_no_auto_restore', 13:55:41 INFO - 'tabpaint']}, 13:55:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:55:41 INFO - 'tests': ['a11yr', 13:55:41 INFO - 'ts_paint', 13:55:41 INFO - 'tpaint', 13:55:41 INFO - 'sessionrestore', 13:55:41 INFO - 'sessionrestore_no_auto_restore', 13:55:41 INFO - 'tabpaint']}, 13:55:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:55:41 INFO - 'tests': ['a11yr', 13:55:41 INFO - 'ts_paint', 13:55:41 INFO - 'tpaint', 13:55:41 INFO - 'sessionrestore', 13:55:41 INFO - 'sessionrestore_no_auto_restore', 13:55:41 INFO - 'tabpaint']}, 13:55:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:55:41 INFO - 'tests': ['tsvgx', 13:55:41 INFO - 'tsvgr_opacity', 13:55:41 INFO - 'tart', 13:55:41 INFO - 'tscrollx', 13:55:41 INFO - 'cart']}, 13:55:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:55:41 INFO - 'tsvgr_opacity', 13:55:41 INFO - 'tart', 13:55:41 INFO - 'tscrollx', 13:55:41 INFO - 'cart']}, 13:55:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:41 INFO - 'talos_options': ['--disable-e10s'], 13:55:41 INFO - 'tests': ['tp5o']}, 13:55:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:41 INFO - 'tests': ['tp5o']}, 13:55:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:41 INFO - 'talos_options': ['--disable-e10s', 13:55:41 INFO - '--xperf_path', 13:55:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:55:41 INFO - 'tests': ['tp5n']}, 13:55:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:41 INFO - 'talos_options': ['--xperf_path', 13:55:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:55:41 INFO - 'tests': ['tp5n']}}, 13:55:41 INFO - 'talos.zip': {'path': '', 13:55:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:55:41 INFO - Running post-action listener: _resource_record_post_action 13:55:41 INFO - ##### 13:55:41 INFO - ##### Running create-virtualenv step. 13:55:41 INFO - ##### 13:55:41 INFO - Running pre-action listener: _resource_record_pre_action 13:55:41 INFO - Running main action method: create_virtualenv 13:55:41 INFO - Creating virtualenv /builds/slave/test/build/venv 13:55:41 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 13:55:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:55:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:55:41 INFO - Using real prefix '/usr' 13:55:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:55:42 INFO - Installing distribute.............................................................................................................................................................................................done. 13:55:44 INFO - Installing pip.................done. 13:55:44 INFO - Return code: 0 13:55:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:55:44 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')]} 13:55:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:44 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')]} 13:55:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:44 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 0x7fc6ed0d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ae410>, '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 0x15af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15af7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1460664761.508680-1226443325', '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 13:55:44 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 13:55:44 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 13:55:44 INFO - Using env: {'DISPLAY': ':0', 13:55:44 INFO - 'HOME': '/home/cltbld', 13:55:44 INFO - 'LANG': 'en_US.UTF-8', 13:55:44 INFO - 'LANGUAGE': 'en_US:en', 13:55:44 INFO - 'LOGNAME': 'cltbld', 13:55:44 INFO - 'MAIL': '/var/mail/cltbld', 13:55:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:44 INFO - 'MOZ_NO_REMOTE': '1', 13:55:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:55:44 INFO - 'NO_EM_RESTART': '1', 13:55:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:55:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:44 INFO - 'PWD': '/builds/slave/test', 13:55:44 INFO - 'SHELL': '/bin/bash', 13:55:44 INFO - 'SHLVL': '1', 13:55:44 INFO - 'TERM': 'linux', 13:55:44 INFO - 'TMOUT': '86400', 13:55:44 INFO - 'USER': 'cltbld', 13:55:44 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1460664761.508680-1226443325', 13:55:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:44 INFO - '_': '/tools/buildbot/bin/python'} 13:55:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:44 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 13:55:44 INFO - Cleaning up... 13:55:44 INFO - Return code: 0 13:55:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:55:44 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')]} 13:55:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:44 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')]} 13:55:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:44 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6ed0d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ae410>, '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 0x15af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15af7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1460664761.508680-1226443325', '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 13:55:44 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>=0.7.1'] in /builds/slave/test/build 13:55:44 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>=0.7.1 13:55:44 INFO - Using env: {'DISPLAY': ':0', 13:55:44 INFO - 'HOME': '/home/cltbld', 13:55:44 INFO - 'LANG': 'en_US.UTF-8', 13:55:44 INFO - 'LANGUAGE': 'en_US:en', 13:55:44 INFO - 'LOGNAME': 'cltbld', 13:55:44 INFO - 'MAIL': '/var/mail/cltbld', 13:55:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:44 INFO - 'MOZ_NO_REMOTE': '1', 13:55:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:55:44 INFO - 'NO_EM_RESTART': '1', 13:55:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:55:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:44 INFO - 'PWD': '/builds/slave/test', 13:55:44 INFO - 'SHELL': '/bin/bash', 13:55:44 INFO - 'SHLVL': '1', 13:55:44 INFO - 'TERM': 'linux', 13:55:44 INFO - 'TMOUT': '86400', 13:55:44 INFO - 'USER': 'cltbld', 13:55:44 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1460664761.508680-1226443325', 13:55:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:44 INFO - '_': '/tools/buildbot/bin/python'} 13:55:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:44 INFO - Downloading/unpacking psutil>=0.7.1 13:55:44 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 13:55:44 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 13:55:44 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 13:55:44 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 13:55:44 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 13:55:44 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 13:55:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:55:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:55:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:55:46 INFO - Installing collected packages: psutil 13:55:46 INFO - Running setup.py install for psutil 13:55:46 INFO - building 'psutil._psutil_linux' extension 13:55:46 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 13:55:46 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 13:55:46 INFO - building 'psutil._psutil_posix' extension 13:55:46 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 13:55:47 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 13:55:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:55:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:55:47 INFO - Successfully installed psutil 13:55:47 INFO - Cleaning up... 13:55:47 INFO - Return code: 0 13:55:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:55: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')]} 13:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55: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')]} 13:55:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55: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', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6ed0d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ae410>, '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 0x15af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15af7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1460664761.508680-1226443325', '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 13:55: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 13:55: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 mozsystemmonitor==0.0.0 13:55:47 INFO - Using env: {'DISPLAY': ':0', 13:55:47 INFO - 'HOME': '/home/cltbld', 13:55:47 INFO - 'LANG': 'en_US.UTF-8', 13:55:47 INFO - 'LANGUAGE': 'en_US:en', 13:55:47 INFO - 'LOGNAME': 'cltbld', 13:55:47 INFO - 'MAIL': '/var/mail/cltbld', 13:55:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:47 INFO - 'MOZ_NO_REMOTE': '1', 13:55:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:55:47 INFO - 'NO_EM_RESTART': '1', 13:55:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:55:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:47 INFO - 'PWD': '/builds/slave/test', 13:55:47 INFO - 'SHELL': '/bin/bash', 13:55:47 INFO - 'SHLVL': '1', 13:55:47 INFO - 'TERM': 'linux', 13:55:47 INFO - 'TMOUT': '86400', 13:55:47 INFO - 'USER': 'cltbld', 13:55:47 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1460664761.508680-1226443325', 13:55:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:47 INFO - '_': '/tools/buildbot/bin/python'} 13:55:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:55:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:55:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:55:49 INFO - Installing collected packages: mozsystemmonitor 13:55:49 INFO - Running setup.py install for mozsystemmonitor 13:55:49 INFO - Successfully installed mozsystemmonitor 13:55:49 INFO - Cleaning up... 13:55:49 INFO - Return code: 0 13:55:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:55:49 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')]} 13:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:49 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')]} 13:55:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:49 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 0x7fc6ed0d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ae410>, '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 0x15af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15af7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1460664761.508680-1226443325', '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 13:55:49 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 13:55:49 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 13:55:49 INFO - Using env: {'DISPLAY': ':0', 13:55:49 INFO - 'HOME': '/home/cltbld', 13:55:49 INFO - 'LANG': 'en_US.UTF-8', 13:55:49 INFO - 'LANGUAGE': 'en_US:en', 13:55:49 INFO - 'LOGNAME': 'cltbld', 13:55:49 INFO - 'MAIL': '/var/mail/cltbld', 13:55:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:49 INFO - 'MOZ_NO_REMOTE': '1', 13:55:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:55:49 INFO - 'NO_EM_RESTART': '1', 13:55:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:55:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:49 INFO - 'PWD': '/builds/slave/test', 13:55:49 INFO - 'SHELL': '/bin/bash', 13:55:49 INFO - 'SHLVL': '1', 13:55:49 INFO - 'TERM': 'linux', 13:55:49 INFO - 'TMOUT': '86400', 13:55:49 INFO - 'USER': 'cltbld', 13:55:49 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1460664761.508680-1226443325', 13:55:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:49 INFO - '_': '/tools/buildbot/bin/python'} 13:55:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:49 INFO - Downloading/unpacking blobuploader==1.2.4 13:55:49 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 13:55:49 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 13:55:49 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 13:55:49 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 13:55:49 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 13:55:49 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 13:55:51 INFO - Downloading blobuploader-1.2.4.tar.gz 13:55:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:55:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:55:51 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 13:55:51 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 13:55:51 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 13:55:51 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 13:55:51 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 13:55:51 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 13:55:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:55:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:55:52 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 13:55:52 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 13:55:52 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 13:55:52 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 13:55:52 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 13:55:52 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 13:55:52 INFO - Downloading docopt-0.6.1.tar.gz 13:55:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:55:52 INFO - Installing collected packages: blobuploader, requests, docopt 13:55:52 INFO - Running setup.py install for blobuploader 13:55:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:55:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:55:52 INFO - Running setup.py install for requests 13:55:52 INFO - Running setup.py install for docopt 13:55:52 INFO - Successfully installed blobuploader requests docopt 13:55:52 INFO - Cleaning up... 13:55:52 INFO - Return code: 0 13:55:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:55:52 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')]} 13:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:52 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')]} 13:55:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:52 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 0x7fc6ed0d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ae410>, '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 0x15af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15af7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1460664761.508680-1226443325', '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 13:55:52 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 13:55:52 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 13:55:52 INFO - Using env: {'DISPLAY': ':0', 13:55:52 INFO - 'HOME': '/home/cltbld', 13:55:52 INFO - 'LANG': 'en_US.UTF-8', 13:55:52 INFO - 'LANGUAGE': 'en_US:en', 13:55:52 INFO - 'LOGNAME': 'cltbld', 13:55:52 INFO - 'MAIL': '/var/mail/cltbld', 13:55:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:52 INFO - 'MOZ_NO_REMOTE': '1', 13:55:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:55:52 INFO - 'NO_EM_RESTART': '1', 13:55:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:55:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:52 INFO - 'PWD': '/builds/slave/test', 13:55:52 INFO - 'SHELL': '/bin/bash', 13:55:52 INFO - 'SHLVL': '1', 13:55:52 INFO - 'TERM': 'linux', 13:55:52 INFO - 'TMOUT': '86400', 13:55:52 INFO - 'USER': 'cltbld', 13:55:52 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1460664761.508680-1226443325', 13:55:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:52 INFO - '_': '/tools/buildbot/bin/python'} 13:55:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:55:53 INFO - Running setup.py (path:/tmp/pip-uYJBRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:55:53 INFO - Running setup.py (path:/tmp/pip-sKqC1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:55:53 INFO - Running setup.py (path:/tmp/pip-sPJ8SV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:55:53 INFO - Running setup.py (path:/tmp/pip-PPfkdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:55:53 INFO - Running setup.py (path:/tmp/pip-0PAAF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:55:53 INFO - Running setup.py (path:/tmp/pip-g_pA58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:55:53 INFO - Running setup.py (path:/tmp/pip-OtXUuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:55:53 INFO - Running setup.py (path:/tmp/pip-xYXFz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:55:53 INFO - Running setup.py (path:/tmp/pip-IfBv3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:55:53 INFO - Running setup.py (path:/tmp/pip-wiCk8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:55:53 INFO - Running setup.py (path:/tmp/pip-W8VMOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:55:53 INFO - Running setup.py (path:/tmp/pip-Dtwdqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:55:53 INFO - Running setup.py (path:/tmp/pip-d3Izxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:55:54 INFO - Running setup.py (path:/tmp/pip-ijdzTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:55:54 INFO - Running setup.py (path:/tmp/pip-licekj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:55:54 INFO - Running setup.py (path:/tmp/pip-9hOFAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:55:54 INFO - Running setup.py (path:/tmp/pip-jKHllm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:55:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:55:54 INFO - Running setup.py install for manifestparser 13:55:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:55:54 INFO - Running setup.py install for mozcrash 13:55:54 INFO - Running setup.py install for mozdebug 13:55:54 INFO - Running setup.py install for mozdevice 13:55:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:55:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:55:54 INFO - Running setup.py install for mozfile 13:55:54 INFO - Running setup.py install for mozhttpd 13:55:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:55:54 INFO - Running setup.py install for mozinfo 13:55:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:55:55 INFO - Running setup.py install for mozInstall 13:55:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:55:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:55:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:55:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:55:55 INFO - Running setup.py install for mozleak 13:55:55 INFO - Running setup.py install for mozlog 13:55:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:55:55 INFO - Running setup.py install for moznetwork 13:55:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:55:55 INFO - Running setup.py install for mozprocess 13:55:55 INFO - Running setup.py install for mozprofile 13:55:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:55:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:55:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:55:55 INFO - Running setup.py install for mozrunner 13:55:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:55:55 INFO - Running setup.py install for mozscreenshot 13:55:55 INFO - Running setup.py install for moztest 13:55:56 INFO - Running setup.py install for mozversion 13:55:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:55:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:55:56 INFO - Cleaning up... 13:55:56 INFO - Return code: 0 13:55:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:55:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:55:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:56 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 0x7fc6ed0d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ae410>, '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 0x15af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15af7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1460664761.508680-1226443325', '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 13:55:56 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 13:55:56 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 13:55:56 INFO - Using env: {'DISPLAY': ':0', 13:55:56 INFO - 'HOME': '/home/cltbld', 13:55:56 INFO - 'LANG': 'en_US.UTF-8', 13:55:56 INFO - 'LANGUAGE': 'en_US:en', 13:55:56 INFO - 'LOGNAME': 'cltbld', 13:55:56 INFO - 'MAIL': '/var/mail/cltbld', 13:55:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:56 INFO - 'MOZ_NO_REMOTE': '1', 13:55:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:55:56 INFO - 'NO_EM_RESTART': '1', 13:55:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:55:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:56 INFO - 'PWD': '/builds/slave/test', 13:55:56 INFO - 'SHELL': '/bin/bash', 13:55:56 INFO - 'SHLVL': '1', 13:55:56 INFO - 'TERM': 'linux', 13:55:56 INFO - 'TMOUT': '86400', 13:55:56 INFO - 'USER': 'cltbld', 13:55:56 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1460664761.508680-1226443325', 13:55:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:56 INFO - '_': '/tools/buildbot/bin/python'} 13:55:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:55:56 INFO - Running setup.py (path:/tmp/pip-1E442t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:55:56 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)) 13:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:55:56 INFO - Running setup.py (path:/tmp/pip-K_Qyec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:55:56 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)) 13:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:55:56 INFO - Running setup.py (path:/tmp/pip-tYj8cq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:55:56 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)) 13:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:55:56 INFO - Running setup.py (path:/tmp/pip-YPqDMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:55:56 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)) 13:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:55:56 INFO - Running setup.py (path:/tmp/pip-_DaOmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:55:56 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)) 13:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:55:56 INFO - Running setup.py (path:/tmp/pip-u8Ci4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:55:56 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)) 13:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:55:56 INFO - Running setup.py (path:/tmp/pip-LPCik5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:55:56 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)) 13:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:55:56 INFO - Running setup.py (path:/tmp/pip-SnIsgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:55:56 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)) 13:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:55:56 INFO - Running setup.py (path:/tmp/pip-jLnhAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:55:56 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)) 13:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:55:57 INFO - Running setup.py (path:/tmp/pip-BBWV8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:55:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 13:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:55:57 INFO - Running setup.py (path:/tmp/pip-Bvp1Cv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:55:57 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)) 13:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:55:57 INFO - Running setup.py (path:/tmp/pip-hksFjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:55:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:55:57 INFO - Running setup.py (path:/tmp/pip-EmcdOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:55:57 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)) 13:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:55:57 INFO - Running setup.py (path:/tmp/pip-aELFg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:55:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:55:57 INFO - Running setup.py (path:/tmp/pip-CxEtf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:55:57 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)) 13:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:55:57 INFO - Running setup.py (path:/tmp/pip-gga5av-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:55:57 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)) 13:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:55:57 INFO - Running setup.py (path:/tmp/pip-jxZt9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:55:57 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)) 13:55:57 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)) 13:55:57 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)) 13:55:57 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)) 13:55:57 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)) 13:55:57 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)) 13:55:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:55:57 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 13:55:57 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 13:55:57 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 13:55:57 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 13:55:57 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 13:55:57 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 13:55:59 INFO - Downloading blessings-1.6.tar.gz 13:55:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:55:59 INFO - Installing collected packages: blessings 13:55:59 INFO - Running setup.py install for blessings 13:55:59 INFO - Successfully installed blessings 13:55:59 INFO - Cleaning up... 13:55:59 INFO - Return code: 0 13:55:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:55:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:55:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:55:59 INFO - Reading from file tmpfile_stdout 13:55:59 INFO - Current package versions: 13:55:59 INFO - argparse == 1.2.1 13:55:59 INFO - blessings == 1.6 13:55:59 INFO - blobuploader == 1.2.4 13:55:59 INFO - docopt == 0.6.1 13:55:59 INFO - manifestparser == 1.1 13:55:59 INFO - mozInstall == 1.12 13:55:59 INFO - mozcrash == 0.17 13:55:59 INFO - mozdebug == 0.1 13:55:59 INFO - mozdevice == 0.48 13:55:59 INFO - mozfile == 1.2 13:55:59 INFO - mozhttpd == 0.7 13:55:59 INFO - mozinfo == 0.9 13:55:59 INFO - mozleak == 0.1 13:55:59 INFO - mozlog == 3.1 13:55:59 INFO - moznetwork == 0.27 13:55:59 INFO - mozprocess == 0.22 13:55:59 INFO - mozprofile == 0.28 13:55:59 INFO - mozrunner == 6.11 13:55:59 INFO - mozscreenshot == 0.1 13:55:59 INFO - mozsystemmonitor == 0.0 13:55:59 INFO - moztest == 0.7 13:55:59 INFO - mozversion == 1.4 13:55:59 INFO - psutil == 3.1.1 13:55:59 INFO - requests == 1.2.3 13:55:59 INFO - wsgiref == 0.1.2 13:55:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:55: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')]} 13:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55: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')]} 13:55:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:59 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 0x7fc6ed0d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ae410>, '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 0x15af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15af7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1460664761.508680-1226443325', '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 13:55:59 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 13:55:59 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 13:55:59 INFO - Using env: {'DISPLAY': ':0', 13:55:59 INFO - 'HOME': '/home/cltbld', 13:55:59 INFO - 'LANG': 'en_US.UTF-8', 13:55:59 INFO - 'LANGUAGE': 'en_US:en', 13:55:59 INFO - 'LOGNAME': 'cltbld', 13:55:59 INFO - 'MAIL': '/var/mail/cltbld', 13:55:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:59 INFO - 'MOZ_NO_REMOTE': '1', 13:55:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:55:59 INFO - 'NO_EM_RESTART': '1', 13:55:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:55:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:59 INFO - 'PWD': '/builds/slave/test', 13:55:59 INFO - 'SHELL': '/bin/bash', 13:55:59 INFO - 'SHLVL': '1', 13:55:59 INFO - 'TERM': 'linux', 13:55:59 INFO - 'TMOUT': '86400', 13:55:59 INFO - 'USER': 'cltbld', 13:55:59 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1460664761.508680-1226443325', 13:55:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:59 INFO - '_': '/tools/buildbot/bin/python'} 13:56:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:00 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)) 13:56:00 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)) 13:56:00 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)) 13:56:00 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)) 13:56:00 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)) 13:56:00 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)) 13:56:00 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)) 13:56:00 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)) 13:56:00 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)) 13:56:00 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)) 13:56:00 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)) 13:56:00 INFO - Cleaning up... 13:56:00 INFO - Return code: 0 13:56:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:56:00 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')]} 13:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:00 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')]} 13:56:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:00 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 0x7fc6ed0d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ae410>, '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 0x15af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15af7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1460664761.508680-1226443325', '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 13:56:00 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 13:56:00 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 13:56:00 INFO - Using env: {'DISPLAY': ':0', 13:56:00 INFO - 'HOME': '/home/cltbld', 13:56:00 INFO - 'LANG': 'en_US.UTF-8', 13:56:00 INFO - 'LANGUAGE': 'en_US:en', 13:56:00 INFO - 'LOGNAME': 'cltbld', 13:56:00 INFO - 'MAIL': '/var/mail/cltbld', 13:56:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:00 INFO - 'MOZ_NO_REMOTE': '1', 13:56:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:56:00 INFO - 'NO_EM_RESTART': '1', 13:56:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:56:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:00 INFO - 'PWD': '/builds/slave/test', 13:56:00 INFO - 'SHELL': '/bin/bash', 13:56:00 INFO - 'SHLVL': '1', 13:56:00 INFO - 'TERM': 'linux', 13:56:00 INFO - 'TMOUT': '86400', 13:56:00 INFO - 'USER': 'cltbld', 13:56:00 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1460664761.508680-1226443325', 13:56:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:00 INFO - '_': '/tools/buildbot/bin/python'} 13:56:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:00 INFO - Downloading/unpacking jsonschema 13:56:00 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 13:56:00 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 13:56:00 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 13:56:00 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 13:56:00 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 13:56:00 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 13:56:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:56:02 INFO - Downloading/unpacking functools32 (from jsonschema) 13:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:02 INFO - Downloading functools32-3.2.3-2.tar.gz 13:56:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:56:02 INFO - warning: no files found matching '*.txt' 13:56:02 INFO - no previously-included directories found matching 'build' 13:56:02 INFO - no previously-included directories found matching 'dist' 13:56:02 INFO - no previously-included directories found matching '.git*' 13:56:02 INFO - Installing collected packages: jsonschema, functools32 13:56:02 INFO - Running setup.py install for functools32 13:56:02 INFO - warning: no files found matching '*.txt' 13:56:02 INFO - no previously-included directories found matching 'build' 13:56:02 INFO - no previously-included directories found matching 'dist' 13:56:02 INFO - no previously-included directories found matching '.git*' 13:56:02 INFO - Successfully installed jsonschema functools32 13:56:02 INFO - Cleaning up... 13:56:02 INFO - Return code: 0 13:56:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:56: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')]} 13:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56: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')]} 13:56:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6ed0d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ae410>, '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 0x15af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15af7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1460664761.508680-1226443325', '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 13:56:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 13:56:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:56:02 INFO - Using env: {'DISPLAY': ':0', 13:56:02 INFO - 'HOME': '/home/cltbld', 13:56:02 INFO - 'LANG': 'en_US.UTF-8', 13:56:02 INFO - 'LANGUAGE': 'en_US:en', 13:56:02 INFO - 'LOGNAME': 'cltbld', 13:56:02 INFO - 'MAIL': '/var/mail/cltbld', 13:56:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:02 INFO - 'MOZ_NO_REMOTE': '1', 13:56:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:56:02 INFO - 'NO_EM_RESTART': '1', 13:56:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:56:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:02 INFO - 'PWD': '/builds/slave/test', 13:56:02 INFO - 'SHELL': '/bin/bash', 13:56:02 INFO - 'SHLVL': '1', 13:56:02 INFO - 'TERM': 'linux', 13:56:02 INFO - 'TMOUT': '86400', 13:56:02 INFO - 'USER': 'cltbld', 13:56:02 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1460664761.508680-1226443325', 13:56:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:02 INFO - '_': '/tools/buildbot/bin/python'} 13:56:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:02 INFO - Downloading/unpacking flake8 13:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:56:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:56: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 13:56: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 13:56: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 13:56: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 13:56: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 13:56: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 13:56:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:56:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:56:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:56:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:56:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:56:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:56:05 INFO - no previously-included directories found matching 'docs/_build' 13:56:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:56:05 INFO - Running setup.py install for pep8 13:56:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:56:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:56:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:56:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:56:05 INFO - no previously-included directories found matching 'docs/_build' 13:56:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:56:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:56:05 INFO - Cleaning up... 13:56:05 INFO - Return code: 0 13:56:05 INFO - Running post-action listener: _resource_record_post_action 13:56:05 INFO - Running post-action listener: _start_resource_monitoring 13:56:05 INFO - Starting resource monitoring. 13:56:05 INFO - ##### 13:56:05 INFO - ##### Running install step. 13:56:05 INFO - ##### 13:56:05 INFO - Running pre-action listener: _resource_record_pre_action 13:56:05 INFO - Running main action method: install 13:56:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:56:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:56:06 INFO - Reading from file tmpfile_stdout 13:56:06 INFO - Detecting whether we're running mozinstall >=1.0... 13:56:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:56:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:56:06 INFO - Reading from file tmpfile_stdout 13:56:06 INFO - Output received: 13:56:06 INFO - Usage: mozinstall [options] installer 13:56:06 INFO - Options: 13:56:06 INFO - -h, --help show this help message and exit 13:56:06 INFO - -d DEST, --destination=DEST 13:56:06 INFO - Directory to install application into. [default: 13:56:06 INFO - "/builds/slave/test"] 13:56:06 INFO - --app=APP Application being installed. [default: firefox] 13:56:06 INFO - mkdir: /builds/slave/test/build/application 13:56:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:56:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:56:21 INFO - Reading from file tmpfile_stdout 13:56:21 INFO - Output received: 13:56:21 INFO - /builds/slave/test/build/application/firefox/firefox 13:56:21 INFO - Running post-action listener: _resource_record_post_action 13:56:21 INFO - ##### 13:56:21 INFO - ##### Running run-tests step. 13:56:21 INFO - ##### 13:56:21 INFO - Running pre-action listener: _resource_record_pre_action 13:56:21 INFO - Running main action method: run_tests 13:56:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:56:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:56:21 INFO - Python 2.7.3 13:56:21 INFO - Return code: 0 13:56:21 INFO - grabbing minidump binary from tooltool 13:56:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:56:21 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ae410>, '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 0x15af310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15af7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:56:21 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 13:56:21 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 13:56:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:56:21 INFO - Return code: 0 13:56:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:56:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:56:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:56:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:56:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:56:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:56:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:56:22 INFO - Return code: 0 13:56:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YUAMftqOSXi4jPiCKqiqdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 13:56:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YUAMftqOSXi4jPiCKqiqdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 13:56:22 INFO - Using env: {'DISPLAY': ':0', 13:56:22 INFO - 'HOME': '/home/cltbld', 13:56:22 INFO - 'LANG': 'en_US.UTF-8', 13:56:22 INFO - 'LANGUAGE': 'en_US:en', 13:56:22 INFO - 'LOGNAME': 'cltbld', 13:56:22 INFO - 'MAIL': '/var/mail/cltbld', 13:56:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:56:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:56:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:22 INFO - 'MOZ_NO_REMOTE': '1', 13:56:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:56:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:56:22 INFO - 'NO_EM_RESTART': '1', 13:56:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:56:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:22 INFO - 'PWD': '/builds/slave/test', 13:56:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:56:22 INFO - 'SHELL': '/bin/bash', 13:56:22 INFO - 'SHLVL': '1', 13:56:22 INFO - 'TERM': 'linux', 13:56:22 INFO - 'TMOUT': '86400', 13:56:22 INFO - 'USER': 'cltbld', 13:56:22 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1460664761.508680-1226443325', 13:56:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:22 INFO - '_': '/tools/buildbot/bin/python'} 13:56:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YUAMftqOSXi4jPiCKqiqdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 13:56:23 INFO - mozversion application_buildid: 20160414125440 13:56:23 INFO - mozversion application_changeset: 43d9dbd33ab796c4abb1cf973bb6c9d3d94a6e39 13:56:23 INFO - mozversion application_display_name: Nightly 13:56:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:56:23 INFO - mozversion application_name: Firefox 13:56:23 INFO - mozversion application_remotingname: firefox 13:56:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:56:23 INFO - mozversion application_vendor: Mozilla 13:56:23 INFO - mozversion application_version: 48.0a1 13:56:23 INFO - mozversion platform_buildid: 20160414125440 13:56:23 INFO - mozversion platform_changeset: 43d9dbd33ab796c4abb1cf973bb6c9d3d94a6e39 13:56:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:56:23 INFO - mozversion platform_version: 48.0a1 13:56:23 INFO - using testdate: 1460667383 13:56:23 INFO - actual date: 1460667383 13:56:23 INFO - starting webserver on 'localhost:34451' 13:56:23 INFO - SUITE-START | Running 2 tests 13:56:23 INFO - TEST-START | dromaeo_css 13:56:23 INFO - operating with platform_type : linux_ 13:56:23 INFO - Initialising browser for dromaeo_css test... 13:56:23 INFO - TEST-INFO | started process 376 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWlNIuH/profile http://localhost:34451/getInfo.html) 13:56:27 INFO - PROCESS | 376 | 13:56:27 INFO - PROCESS | 376 | (process:448): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:56:27 INFO - PROCESS | 376 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 13:56:28 INFO - PROCESS | 376 | __metrics Screen width/height:1600/1200 13:56:28 INFO - PROCESS | 376 | colorDepth:24 13:56:28 INFO - PROCESS | 376 | Browser inner width/height: 1024/697 13:56:28 INFO - PROCESS | 376 | __metrics 13:56:29 ERROR - PROCESS | 376 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 13:56:30 INFO - TEST-INFO | 376: exit 0 13:56:30 INFO - Browser initialized. 13:56:30 INFO - Running cycle 1/1 for dromaeo_css test... 13:56:30 INFO - TEST-INFO | started process 499 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWlNIuH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:56:32 INFO - PROCESS | 499 | 13:56:32 INFO - PROCESS | 499 | (process:558): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:56:42 INFO - PROCESS | 499 | RSS: Main: 164462592 13:56:42 INFO - PROCESS | 499 | 13:57:31 INFO - PROCESS | 499 | 1460667451730 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] 13:59:44 INFO - PROCESS | 499 | Cycle 1(1): loaded http://localhost:34451/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34451/tests/dromaeo/cssquery-ext.html) 13:59:45 INFO - PROCESS | 499 | RSS: Main: 168742912 13:59:45 INFO - PROCESS | 499 | 14:02:47 INFO - PROCESS | 499 | Cycle 1(1): loaded http://localhost:34451/tests/dromaeo/cssquery-ext.html (next: http://localhost:34451/tests/dromaeo/cssquery-jquery.html) 14:02:47 INFO - PROCESS | 499 | RSS: Main: 167624704 14:02:47 INFO - PROCESS | 499 | 14:05:49 INFO - PROCESS | 499 | Cycle 1(1): loaded http://localhost:34451/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34451/tests/dromaeo/cssquery-mootools.html) 14:05:50 INFO - PROCESS | 499 | RSS: Main: 166612992 14:05:50 INFO - PROCESS | 499 | 14:08:52 INFO - PROCESS | 499 | Cycle 1(1): loaded http://localhost:34451/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34451/tests/dromaeo/cssquery-prototype.html) 14:08:52 INFO - PROCESS | 499 | RSS: Main: 164065280 14:08:52 INFO - PROCESS | 499 | 14:11:55 INFO - PROCESS | 499 | Cycle 1(1): loaded http://localhost:34451/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34451/tests/dromaeo/cssquery-yui.html) 14:11:56 INFO - PROCESS | 499 | RSS: Main: 165793792 14:11:56 INFO - PROCESS | 499 | 14:14:58 INFO - PROCESS | 499 | Cycle 1(1): loaded http://localhost:34451/tests/dromaeo/cssquery-yui.html (next: http://localhost:34451/tests/dromaeo/cssquery-dojo.html) 14:14:58 INFO - PROCESS | 499 | RSS: Main: 167780352 14:14:58 INFO - PROCESS | 499 | 14:14:58 INFO - PROCESS | 499 | __start_tp_report 14:14:58 INFO - PROCESS | 499 | _x_x_mozilla_page_load 14:14:58 INFO - PROCESS | 499 | _x_x_mozilla_page_load_details 14:14:58 INFO - PROCESS | 499 | |i|pagename|runs| 14:14:58 INFO - PROCESS | 499 | |0;dojo.html;2611.08611985805;2716.3480764616484;2755.393813361061;2760.9171724848247;2767.7647399971;4823.083614113316;4826;4829.686070405422;4831.323614693937;4908.8281910133155;4683.250679891218;4755.286706993953;4766.5471780180915;4769.260764581487;4774.474807771142;4371.715838470489;4426.358178064179;4490.169318676056;4561.7491037992895;4573.382593349888;4493.752843593601;4542.909141817162;4543.704659197141;4548.317752337143;4558.61251793598;4467.15124126415;4470.441194850644;4515.435570553681;4529.932051019237;4530.954690453103;4375.431193944799;4474.105178964188;4486.080353527519;4509.571590698911;4513.638908887281;4401.515833258339;4402.735835849827;4407.581279778416;4418.3593378960195;4445.911081778347;4599.70101943376;4682.789274482657;4698.271767875985;4706.1999460091865;4767.261074533453;5167.379914410257;5175.948240517584;5176.896462070775;5185.274061631375;5201.947980520222;5128.9230661540105;5155.458676838953;5169.896602067975;5202.973985130088;5215.061288967984;4720.575148236675;4797.64017698674;4800.975995120002;4808.206645903421;4869.415670119537;5259.605529585297;5270.5256526912;5272.393674727456;5300.893982120336;5315.760790764425;5064.18972964324;5077.1876499759865;5083.974580127076;5084.542391184811;5098.668586541863;5105.489451054939;5113.565346945476;5157.819476318311;5185.274061631375;5205.7917683293;5182.740862956837;5190.377154741455;5219.138842091088;5221.13851214553;5227.26818245446;5156.458571849902;5170.870728231825;5178.223266509978;5187.740612969336;5226.242194881721;4226.57734226581;4236.385724069993;4290.613844753987;4293.720908140961;4363.38912552243;3782.8486860525272;3801.961980380216;3803.220339830328;3835.810898621436;3839.232153569297;4499.6400287976885;4519.570640789119;4524.6380289576755;4554.817807287738;4567.657425693086;5143.228515722597;5177;5244.921326180111;5254.894902101936;5257.263983042377;4461.687681862239;4484.05834774701;4498.347739577743;4499.4150760400935;4563.931541026887;4548.454185497695;4618.769061546909;4622;4635.536446355405;4672.696274742131;4869.269609558594;4892.510748925079;4901.3138160658245;4917.483664215206;4938.283948827472;5172.353455818023;5174.301469301596;5227.634065615523;5232.215167724872;5255.684658920477;4727.763611819464;4795.616350692006;4870.902581948412;4881.58506526935;4905.018996200845;5122.74386280677;5125.948740512547;5162.406323272871;5165.741712914264;5197.740112994411;5215.348081489814;5221.686698798084;5231;5246.737663116753;5282.920756188737;4927.531884470969;5039.420466646383;5053.84838454847;5069.340985671839;5123.001014802077;5011.248312753116;5027.145385284437;5039.596832253337;5048.116579598629;5076.847694569169;4917.852464426073;4961.42943561495;4966.106100901872;4974.651774375759;5028;4935.235038569028;5042.949570504248;5114.053900028507;5114.616403769806;5134.10153223177;4839.564439200489;4879.829205977774;4934.506549345037;4943.134951383566;4989.151844186425 14:14:58 INFO - PROCESS | 499 | |1;ext.html;577.0334689395262;600.9849753756156;607.9848003799905;620.550101176647;635.9364063593644;32677.346453070924;33746.66253337469;33799.83100084502;33909.830450847745;33998.32003359931;37547.4367884482;37981.62018379816;38081.809590952005;38283.617163828356;38335.233295334074;7612.961935190317;7811.960940195291;7841.6079196040255;7843.764687059397;7853.057633084038;7656.693732250703;7846.176151504095;7847.568383738892;7850.646720897545;7865.724699635514;7734.922650773477;7842.215778422169;7842.921570784305;7845.686172553091;7875.684972601118;7756.108047574517;7797.57113358765;7813.687452501893;7833.804154896145;7840.607969601497;7752.5348479091435;7812.218778122199;7853.607319634052;7868.803279918048;7869.763907082796;31791.20521986946;34075.6592434075;34612.82693586516;34652.48021279683;34726.6527334726;2869.1679412970216;2932.178989882836;2970.1535062507082;3191.952120718191;3411.778234414755;24389.26832195037;24604.261872143863;24621;24812.751872481404;24971.126010589724;3341.9498707519406;3343.9498407523906;3376.375370556455;3481.669241422061;3487.5466189395215;150199;150600;150814.24592877075;151412;152465.23767381092;32489.51265731016;32622.67377326244;32766;32815.179620509676;32870.342593148;33751.66248337485;56790;58032.709836451395;58123;58216;14962.177080260473;14981.40074397012;15077.396904123932;15230.619234519005;15246.23768811555;11379.715507112389;11599.88400116005;11610.6516804496;11633.825492617618;11650.766984660258;18471.53821154455;18723.063846807607;18835.152418141217;18866.434006979813;18876.811231887506;6947.305269473012;7020.192677842011;7085.751998680124;7246.166690830517;7272.381847543018;895.9372843900865;947.1712251779693;1013.2755080117752;1028.711960651019;1058.4072919165292;28307.433851322858;28411.147665570064;28902;29058.854705726335;29110;1006.6074231049896;1053.6891616973012;1076.838474228872;1103.1340397787699;1124.8425220469142;14900.776488352683;15164.545063647887;15402.537923862303;15536.223188840513;15537.30082146306;158736;159160;159565.2021739884;159743;160554;49408.25887611689;49497.25754113691;50013.24980125301;50124;50187;1196.8743281955444;1230.1757822259108;1259.9164718342217;1277.974440511203;1286.948522059107;26984.190474285802;28169.295767605156;28383.574246385906;28625.42749144964;29007.564886526296;42766.786166068974;42943.7852810734;43489.56510434855;43501.69494915158;43538.782306088266;316955;318062;318617;318728;318752;25368.11211607585;25589.104381346562;40958.79520602378;42230.577694222666;42382.57617423786;39042.414363783995;39437.6056239434;40273.39589906095;40944;41036;34399.31201375908;35340.469892951114;35421;35442.291154177285;35734.64265357313;33978.8301058503;34570.13574660553;34658.133546661535;34823.825880870434;35072.29855402929;34767.82616086904;34912.30175396529;38063.61936380601;38907.41638875363;38980.80509597434;29240.26899327534;31319.21701957469;31842.84078579592;31962.36075278435;31964.520532192502;24976.875115624305;25145;25179.370515737253;25243.87378063098;25411.618825718 14:14:58 INFO - PROCESS | 499 | |2;jquery.html;373.7682636765206;376.1649138911615;379.27558363525674;384.3120813743399;392.9862454814082;15715.842841571595;16188.27152778125;16977.91511042443;17028.318867245325;17063.57341066474;12017.339046352447;15306.464273750422;16029.278682459288;16072.116033618146;16074.919625401857;4719.858404247878;4850.563449289563;4896.951030489685;4899.265110233458;4907.067657145131;3479.373712731707;4739.36018637483;5165.896682066356;5469;5495.450454954493;5444.673319600817;5455.399906010336;5471.644343117705;5475.917861232085;5484.149956756709;5290.656107353029;5347;5384.273123128406;5401.513863752242;5429.864253393657;5303.390110137345;5328.227407025998;5341.599380046512;5344.118220493614;5348.277982472356;17708.645827083514;19229.326973555857;20036.89981550083;20090;20092;1917.5781328107794;2011.3965810257012;2114.851960362775;2292.518571100071;2402.3393566769105;8601.655933762642;9180.127887850711;9207.17135457812;9274.118958698913;9533.666321678777;1589.507252751639;1699.167407970098;1713.6744018636418;1725.9050752208623;1736.862355157374;59818.40181598172;59996.40003599952;60132.69933650347;60179.79640407211;60678.69660651713;8268.2558569729;8772.605232764541;8885.06706795777;8891.599878005376;9017.09829017093;11708.531658733555;11745.765084698258;11808.232464889754;11811.822822657667;11859.229150105215;6792.626405547742;6819;6830.8633827324165;7018.438524917994;7028.648567571601;6724.865502690017;6765.221999470025;6815.863682726417;6901.689423975933;6937.479689023344;3728.254349130185;3744.513213282256;3764.228333191689;3778.471014058034;3813.3517302058717;1785.7232129020022;1808.0257975630016;1859.8140185981565;1860.7860096089123;1863.4316533457154;916.8166366726681;931.3852857114272;949.0035462764071;964.5418426247617;973.9724590556889;15884.364625415084;16464.753028704577;16623.168841557872;16689.66620667604;16889.324427023028;895.2524641923936;905.651324240159;906.3655441191061;916.8991410944791;936.1060187520901;9348.626054957726;9475.384100033476;9545.713628591153;9563.426194428217;9622.759431014281;401697;402562;407977;408150;408416;77782;80180;80775.59612201901;80786;81078.59460702659;961.2310151878609;967.6032826541084;997.7605374710017;1006.2704539209014;1014.4927536231884;14817.185054822088;14872.479463218735;14984.850151498345;15155.166465844484;15422.537323880302;31952.840235799602;32857.05715314177;34369.82815085909;34576.48135277923;34665;43099;47707.284390733475;47953.280700790216;48210.758946205046;48458.75770621125;5006;6845.657717114024;7466.029416175862;7584.582847943416;7884.250996155356;10292.279540432099;11417.37204453763;11574.421278935852;11640;11743.706407339885;9829.901700982899;10008.39949603026;10112.342697724624;10278.691639250834;10464.581416743245;9610.183134433652;9855.260855436014;10025.849612255675;10312.48437578133;10334.741631459274;10170.135538479311;10202.795944081225;10253.846192306972;10444.843327350247;10449.738756530844;7473.43949203801;7537;7565.6973721050545;7700.691972321269;7738.264864837832;7790.61046947639;9833.950830245803;10298.897011029794;10422.21833362516;10611.31026483276 14:14:58 INFO - PROCESS | 499 | |3;mootools.html;1417.4471955937183;1490.731668299706;1609.3482139733412;1723.6983527882617;1789.5615574184326;6968.233494315621;7596.9744084548565;7668.309852113309;7911.0506739191305;7919.920800791991;7716.2669546393145;7723.150453450116;7749.496282741632;7792.220777922205;7800.843983120349;2182;2217.2572188316853;2220.966685499719;2222.411061068818;2222.48882756966;2188.485705859122;2193.2652561391874;2204.966925496111;2205.40454077399;2205.8235341172667;2147.967780483294;2179.3461961411595;2190.408589680785;2193.8683678979232;2197.549502352022;2136.070809197996;2143.7534683511362;2144.5389241313114;2145.957080858374;2154.6229409853213;2143.2820005298245;2180.3349978256783;2181.727284089489;2185.191479152708;2188.2231807708354;7842.568658723768;7948.364130869517;7988.041435027776;7999;8010.839783204362;4524.524924882873;4693.084848454553;4711.599514041311;4713.080949214905;4722.409698787652;2971.5691224772286;2986.3280761828632;3045.817250964927;3061.8162910225456;3100.085474784944;975.687779910429;1001.7195185348114;1011.8482227665835;1016.547636301846;1045.8117538843005;10542.367457952547;10604.257701960943;10623.097036751886;10662;10683.679489615324;4144.91710165801;4148.688848336386;4343.847965321199;4365.781710914442;4370.2570563004365;8860.246879015227;8952.194302512806;8987.427200240063;9023.729288121367;9039.367244292967;4558.794854231567;4562.771861406916;4577.29051996941;4587.885302867388;4590.67865249436;3578.928421431609;4174.770387628649;4197.664186865043;4216.304309788912;4294;3651.8904432867057;3660.5424321959754;3719.7210209234418;3753.174301653632;3766.7928263945196;1214.7874122028609;1223.687959570304;1232.7226374065942;1233.463443402123;1240.3736113262744;784.6273020315305;806.2139414071233;827.9503229806111;935.3592788939599;947.5499137909438;5330.120530112566;5334.413214546396;5571.749271282802;5711.628744131618;5736.483716465538;822.1901427094307;921.5806807902388;932.6828878181451;948.6502260339661;955.4458414119932;3616.1863580694135;3798.164403831153;3857.286402015636;3886.0867696091395;3895.668868146183;9173.908260917438;9555.140037396668;9606.759831004281;9621.27840411958;9636.373635713657;9829.21366290695;9866.802663946824;9899.455529945779;9937.602495900082;9940.353876997971;7320.743773967885;7406.629668516553;7461;7494.5503269803985;7550.244975502515;5439.972800135974;5573.804916827891;5695.8860822784145;5860.594610719004;5902.5277977762535;8878.600462979051;9081.182693557612;9102.180803727697;9141.405808622418;9167.862482062641;8971.596278167628;9123.133302336268;9152.352576536021;9165.587548560197;9356.391834530734;6124.969375153096;6566.6388348641285;6718.529702920749;6815.42068924147;6831.077804496329;7536.397088233038;7537.962310188634;7604.42966777505;7624.923750762421;7633.69465221385;6653;6740.460763138839;6768.2216545097945;6822.556533825285;6856.588604683735;6776.356246156607;6815.625140617115;6852.486063545154;6964.512484126062;6969.651517424007;6571.507136964651;6601.702923368556;6614.6361950093205;6679.532432729662;6709.463242940651;4934.358533390637;4948.406191257072;4952.925706114339;4956.950430495649;5017.598592112549;5005.424376196784;5038.396329909333;5127.230915362726;5134.281200631989;5134.512221338967 14:14:58 INFO - PROCESS | 499 | |4;prototype.html;314.5863189905275;322.5130053619035;324.10062077734284;328.6664036003455;330.8378894341773;5298.337707786527;5362.597805164619;5367.7584508697055;5402.486763757442;5429.945700542993;5336.119540275859;5337.370588000158;5357.276767636368;5365.7585408656605;5372.892542149155;3941.1329507508303;4038.5153781546255;4172.08214192877;4189.392538081976;4195.706300558947;4172.624463798257;4182.53992060873;4199.076203235299;4199.475065616798;4201.474815648044;4144.336906095025;4155.31437312843;4165.812538435777;4174.436451079096;4175.457190565222;4014.197160567898;4120.464339635858;4130.421740956269;4133.689973252003;4137.668986481074;3633.909152271188;3641.890743277706;3647;3649.9817500912327;3657.414813629833;5120.820771273025;5130.743462826844;5167.560757335631;5168.9224661630105;5169.069567477853;4651.441826980784;4702.553257440538;4755.262934245197;4790.520947905216;4824.807007719687;5585.636933599303;5600.271964644611;5612.971935140339;5649.180868774046;5653.123765816305;3992.740471869319;4009.4787677601726;4026.396040593905;4027.516697996259;4042.454268673721;5773.682447465388;5921.141434491975;5923.407659234085;5933.851653708692;5937.9406205937385;4138.730982486129;4160.687948403821;4167.499900011957;4167.562405947332;4176.0395109125075;4224.070704445017;4235.9364609530885;4235.957640423557;4243.511996120424;4246.554111818215;4710.269908164171;4749.3588365570895;4804.294475461231;4826.541478559531;4827.42070951481;5636.323641163005;5661;5680.4319568042865;5700.515456186271;5711.828645140652;1459.3797636004867;1473.8378778334375;1477.5567329801017;1478.6525166585843;1482.5330021043337;921.741912264567;961.5288508630861;968.8885778135464;1010.8433192855119;1024.4467987286782;4878.512148785093;4916.410030796327;4922.1140194765285;4938.160512712848;4939.987302602958;5718.599698021182;5769.740361683735;5772.740226689809;5777.220075289866;5782.219400380979;4845.3216549683075;4932.4081110267;4953.777080031407;4966.205407134841;4974.875628109254;3102.844857757103;3106.782525223213;3109.626844778641;3112.159716876476;3151.0861850063684;5401.7299135043095;5406.378266499403;5414.891702166014;5440.891182176334;5444.972775136099;5716.979727550135;5887.941120588825;5931.228940237742;5952.839196356756;5953.910691339634;5409.6213265071065;5425.13197888336;5432.158015507603;5436.021516127135;5439.184122381754;5584.106542953108;5737.684427356536;5777.133429985536;5784.2769653793275;5800.332961709458;5691.8292451226525;5716.342620598684;5717.942820571741;5719;5735.8852822944145;5441.891162176655;5444.863878403072;5454.91817622728;5461.972690136524;5465.207544906046;3836.6930645548846;4038.0914294283552;4046.3728122141115;4173.707840451139;4177.644900183518;5859.326177489473;5864.208331875142;5884.235049443545;5886.852828679146;5898.793542226002;5657.886842263214;5673.8297851064535;5681.77272909079;5701.771929122789;5704.914426283692;5494.028338565491;5642.351129620146;5649.7740090397565;5650.0959846424375;5658.519025882846;5339.973300133474;5559.63862348946;5567.137093750475;5576.749046293007;5576.888462230814;5498.147787093007;5668.914966275592;5732.684702341411;5742.109972954198;5756.481916627524;5518.862028449321;5551.472610102034;5583.35791383996;5597.692126933058;5617.269754931996 14:14:58 INFO - PROCESS | 499 | |5;yui.html;735.4226931858491;770.3875419041865;780.9297163255305;782.5578548120311;800.7037396163421;11372.829407558893;11745.119116066297;11942.820857687131;11943.163978521507;12004;11469.713257168574;11668.708282292946;11685;11885.821712674317;11982.40087995601;635.3043417457899;795.7652492514723;811.2658044469764;823.4153750836913;824.6577670266832;806.1454857850667;806.9475484093545;808.5431731071925;809.4212637963855;811.5577010529246;841.6633346661323;846.9576521173948;849.1126772522729;849.8682704180862;851.9574021298941;838.0571856661256;841.1210285251926;842.1368097699846;842.6334544473174;843.8649816029467;618.3569088148321;620.3765215957933;623.8440389902524;624.4629618528062;624.5347216323868;12085.15403921726;12104;12105.697357566043;12150;12153.756924861453;12880;12922.353882305848;13009.934950325187;13103.737925241538;13262;9943.204543636564;10071.647492337734;10077.395356278646;10144.492775361203;10371.948140259326;3331.2005118771563;3352.765306428551;3418.4017796885446;3421.9315613687836;3422.9486557701653;42974.35538466925;43479.782601086794;43604.56395436037;43619.78190109029;43785;9584.616615335448;9754.951225243829;9835.459049752333;9842.458664773363;9886.703398898044;16678.416255431002;16967.74548381775;16991;17014;17046.659066818593;6785;6790;6876.69054892531;7055.858882822315;7131.89302160468;3665;3725.776453412804;3731.738778285548;3766.6233376662112;3876.0503676599415;2860.7711383089304;3029.560713696502;3031.8029328093603;3033.135556366425;3039.6352437707174;539.3851009848776;545.5281181777813;549.881775418287;552.7374497113839;554.6006875049958;565.9037963546207;577.4543056811357;599.9940000600026;608.3247595169358;626.3517259636254;7171.569705817667;7462.888056679154;7562.735304264324;7581.203973582805;7674.309312161932;598.1775059293471;629.0030301971426;629.4555209743539;634.5209366928032;638.9808305750835;3606.3688854450365;3664.798436086041;3710.2950439416422;3710.6845918096724;3769.981150094232;49452;49885;49936.500634993914;49982.25026624603;50047.49952500501;43359.56640433618;44491.11017779626;44558.331625025654;44688.553114468436;45176;39620;40765.59234407677;40993.79503102465;41496.58503414987;41841.79079104585;7248.347648711641;7262.092238470192;7327.780166595011;7379.557226566423;7438.73964411243;28446;28614.427711445238;28689.42621147607;29166.562501562068;29309.70690293155;34194.316113678084;36443.63556364403;36480;36820.44769328516;37593.24813503769;9316.44101353921;9493.193078588121;9548.522573871418;9586.66446674363;9913.851292230478;9748.122668959544;9761.414315141114;9985.800283994426;10001.699949001251;10135.79728405413;8770.693025744069;8872.467651940904;8940.418872773509;9007.414518056305;9162.992070872331;9698.806023879624;9717.951410242904;9779.755506112404;9785.608575656894;10217.540210690686;8906.242969347679;9125.087491250822;9147.268218542367;9293.070692930924;9430.905690943002;8492.915070849212;8720.12798720123;8865.64537418496;8914.465132092095;8934.195922367018;7963.761087167394;8083.272505474535;8117.8376432472205;8276.379271554537;8376.790580235544 14:14:58 INFO - PROCESS | 499 | __end_tp_report 14:14:58 INFO - PROCESS | 499 | __start_cc_report 14:14:58 INFO - PROCESS | 499 | _x_x_mozilla_cycle_collect,378 14:14:58 INFO - PROCESS | 499 | __end_cc_report 14:14:58 INFO - PROCESS | 499 | __startTimestamp1460668498932__endTimestamp 14:14:58 INFO - PROCESS | 499 | 14:14:58 INFO - PROCESS | 499 | ------- Summary: start ------- 14:14:58 INFO - PROCESS | 499 | Number of tests: 6 14:14:58 INFO - PROCESS | 499 | 14:14:58 INFO - PROCESS | 499 | [#0] dojo.html Cycles:165 Average:4782.87 Median:4901.31 stddev:502.13 (10.2%) stddev-sans-first:473.88 14:14:58 INFO - PROCESS | 499 | Values: 2611.1 2716.3 2755.4 2760.9 2767.8 4823.1 4826.0 4829.7 4831.3 4908.8 4683.3 4755.3 4766.5 4769.3 4774.5 4371.7 4426.4 4490.2 4561.7 4573.4 4493.8 4542.9 4543.7 4548.3 4558.6 4467.2 4470.4 4515.4 4529.9 4531.0 4375.4 4474.1 4486.1 4509.6 4513.6 4401.5 4402.7 4407.6 4418.4 4445.9 4599.7 4682.8 4698.3 4706.2 4767.3 5167.4 5175.9 5176.9 5185.3 5201.9 5128.9 5155.5 5169.9 5203.0 5215.1 4720.6 4797.6 4801.0 4808.2 4869.4 5259.6 5270.5 5272.4 5300.9 5315.8 5064.2 5077.2 5084.0 5084.5 5098.7 5105.5 5113.6 5157.8 5185.3 5205.8 5182.7 5190.4 5219.1 5221.1 5227.3 5156.5 5170.9 5178.2 5187.7 5226.2 4226.6 4236.4 4290.6 4293.7 4363.4 3782.8 3802.0 3803.2 3835.8 3839.2 4499.6 4519.6 4524.6 4554.8 4567.7 5143.2 5177.0 5244.9 5254.9 5257.3 4461.7 4484.1 4498.3 4499.4 4563.9 4548.5 4618.8 4622.0 4635.5 4672.7 4869.3 4892.5 4901.3 4917.5 4938.3 5172.4 5174.3 5227.6 5232.2 5255.7 4727.8 4795.6 4870.9 4881.6 4905.0 5122.7 5125.9 5162.4 5165.7 5197.7 5215.3 5221.7 5231.0 5246.7 5282.9 4927.5 5039.4 5053.8 5069.3 5123.0 5011.2 5027.1 5039.6 5048.1 5076.8 4917.9 4961.4 4966.1 4974.7 5028.0 4935.2 5042.9 5114.1 5114.6 5134.1 4839.6 4879.8 4934.5 4943.1 4989.2 14:14:58 INFO - PROCESS | 499 | 14:14:58 INFO - PROCESS | 499 | [#1] ext.html Cycles:180 Average:37534.16 Median:18588.10 stddev:58572.67 (315.1%) stddev-sans-first:58671.25 14:14:58 INFO - PROCESS | 499 | Values: 577.0 601.0 608.0 620.6 635.9 32677.3 33746.7 33799.8 33909.8 33998.3 37547.4 37981.6 38081.8 38283.6 38335.2 7613.0 7812.0 7841.6 7843.8 7853.1 7656.7 7846.2 7847.6 7850.6 7865.7 7734.9 7842.2 7842.9 7845.7 7875.7 7756.1 7797.6 7813.7 7833.8 7840.6 7752.5 7812.2 7853.6 7868.8 7869.8 31791.2 34075.7 34612.8 34652.5 34726.7 2869.2 2932.2 2970.2 3192.0 3411.8 24389.3 24604.3 24621.0 24812.8 24971.1 3341.9 3343.9 3376.4 3481.7 3487.5 150199.0 150600.0 150814.2 151412.0 152465.2 32489.5 32622.7 32766.0 32815.2 32870.3 33751.7 56790.0 58032.7 58123.0 58216.0 14962.2 14981.4 15077.4 15230.6 15246.2 11379.7 11599.9 11610.7 11633.8 11650.8 18471.5 18723.1 18835.2 18866.4 18876.8 6947.3 7020.2 7085.8 7246.2 7272.4 895.9 947.2 1013.3 1028.7 1058.4 28307.4 28411.1 28902.0 29058.9 29110.0 1006.6 1053.7 1076.8 1103.1 1124.8 14900.8 15164.5 15402.5 15536.2 15537.3 158736.0 159160.0 159565.2 159743.0 160554.0 49408.3 49497.3 50013.2 50124.0 50187.0 1196.9 1230.2 1259.9 1278.0 1286.9 26984.2 28169.3 28383.6 28625.4 29007.6 42766.8 42943.8 43489.6 43501.7 43538.8 316955.0 318062.0 318617.0 318728.0 318752.0 25368.1 25589.1 40958.8 42230.6 42382.6 39042.4 39437.6 40273.4 40944.0 41036.0 34399.3 35340.5 35421.0 35442.3 35734.6 33978.8 34570.1 34658.1 34823.8 35072.3 34767.8 34912.3 38063.6 38907.4 38980.8 29240.3 31319.2 31842.8 31962.4 31964.5 24976.9 25145.0 25179.4 25243.9 25411.6 14:14:58 INFO - PROCESS | 499 | 14:14:58 INFO - PROCESS | 499 | [#2] jquery.html Cycles:180 Average:24088.14 Median:26223.32 stddev:66817.70 (254.8%) stddev-sans-first:66981.42 14:14:58 INFO - PROCESS | 499 | Values: 373.8 376.2 379.3 384.3 393.0 15715.8 16188.3 16977.9 17028.3 17063.6 12017.3 15306.5 16029.3 16072.1 16074.9 4719.9 4850.6 4897.0 4899.3 4907.1 3479.4 4739.4 5165.9 5469.0 5495.5 5444.7 5455.4 5471.6 5475.9 5484.1 5290.7 5347.0 5384.3 5401.5 5429.9 5303.4 5328.2 5341.6 5344.1 5348.3 17708.6 19229.3 20036.9 20090.0 20092.0 1917.6 2011.4 2114.9 2292.5 2402.3 8601.7 9180.1 9207.2 9274.1 9533.7 1589.5 1699.2 1713.7 1725.9 1736.9 59818.4 59996.4 60132.7 60179.8 60678.7 8268.3 8772.6 8885.1 8891.6 9017.1 11708.5 11745.8 11808.2 11811.8 11859.2 6792.6 6819.0 6830.9 7018.4 7028.6 6724.9 6765.2 6815.9 6901.7 6937.5 3728.3 3744.5 3764.2 3778.5 3813.4 1785.7 1808.0 1859.8 1860.8 1863.4 916.8 931.4 949.0 964.5 974.0 15884.4 16464.8 16623.2 16689.7 16889.3 895.3 905.7 906.4 916.9 936.1 9348.6 9475.4 9545.7 9563.4 9622.8 401697.0 402562.0 407977.0 408150.0 408416.0 77782.0 80180.0 80775.6 80786.0 81078.6 961.2 967.6 997.8 1006.3 1014.5 14817.2 14872.5 14984.9 15155.2 15422.5 31952.8 32857.1 34369.8 34576.5 34665.0 43099.0 47707.3 47953.3 48210.8 48458.8 5006.0 6845.7 7466.0 7584.6 7884.3 10292.3 11417.4 11574.4 11640.0 11743.7 9829.9 10008.4 10112.3 10278.7 10464.6 9610.2 9855.3 10025.8 10312.5 10334.7 10170.1 10202.8 10253.8 10444.8 10449.7 7473.4 7537.0 7565.7 7700.7 7738.3 7790.6 9834.0 10298.9 10422.2 10611.3 14:14:58 INFO - PROCESS | 499 | 14:14:58 INFO - PROCESS | 499 | [#3] mootools.html Cycles:180 Average:5235.48 Median:5387.19 stddev:2877.33 (53.4%) stddev-sans-first:2871.09 14:14:58 INFO - PROCESS | 499 | Values: 1417.4 1490.7 1609.3 1723.7 1789.6 6968.2 7597.0 7668.3 7911.1 7919.9 7716.3 7723.2 7749.5 7792.2 7800.8 2182.0 2217.3 2221.0 2222.4 2222.5 2188.5 2193.3 2205.0 2205.4 2205.8 2148.0 2179.3 2190.4 2193.9 2197.5 2136.1 2143.8 2144.5 2146.0 2154.6 2143.3 2180.3 2181.7 2185.2 2188.2 7842.6 7948.4 7988.0 7999.0 8010.8 4524.5 4693.1 4711.6 4713.1 4722.4 2971.6 2986.3 3045.8 3061.8 3100.1 975.7 1001.7 1011.8 1016.5 1045.8 10542.4 10604.3 10623.1 10662.0 10683.7 4144.9 4148.7 4343.8 4365.8 4370.3 8860.2 8952.2 8987.4 9023.7 9039.4 4558.8 4562.8 4577.3 4587.9 4590.7 3578.9 4174.8 4197.7 4216.3 4294.0 3651.9 3660.5 3719.7 3753.2 3766.8 1214.8 1223.7 1232.7 1233.5 1240.4 784.6 806.2 828.0 935.4 947.5 5330.1 5334.4 5571.7 5711.6 5736.5 822.2 921.6 932.7 948.7 955.4 3616.2 3798.2 3857.3 3886.1 3895.7 9173.9 9555.1 9606.8 9621.3 9636.4 9829.2 9866.8 9899.5 9937.6 9940.4 7320.7 7406.6 7461.0 7494.6 7550.2 5440.0 5573.8 5695.9 5860.6 5902.5 8878.6 9081.2 9102.2 9141.4 9167.9 8971.6 9123.1 9152.4 9165.6 9356.4 6125.0 6566.6 6718.5 6815.4 6831.1 7536.4 7538.0 7604.4 7624.9 7633.7 6653.0 6740.5 6768.2 6822.6 6856.6 6776.4 6815.6 6852.5 6964.5 6969.7 6571.5 6601.7 6614.6 6679.5 6709.5 4934.4 4948.4 4952.9 4957.0 5017.6 5005.4 5038.4 5127.2 5134.3 5134.5 14:14:58 INFO - PROCESS | 499 | 14:14:58 INFO - PROCESS | 499 | [#4] prototype.html Cycles:180 Average:4677.93 Median:5348.63 stddev:1358.19 (25.4%) stddev-sans-first:1321.93 14:14:58 INFO - PROCESS | 499 | Values: 314.6 322.5 324.1 328.7 330.8 5298.3 5362.6 5367.8 5402.5 5429.9 5336.1 5337.4 5357.3 5365.8 5372.9 3941.1 4038.5 4172.1 4189.4 4195.7 4172.6 4182.5 4199.1 4199.5 4201.5 4144.3 4155.3 4165.8 4174.4 4175.5 4014.2 4120.5 4130.4 4133.7 4137.7 3633.9 3641.9 3647.0 3650.0 3657.4 5120.8 5130.7 5167.6 5168.9 5169.1 4651.4 4702.6 4755.3 4790.5 4824.8 5585.6 5600.3 5613.0 5649.2 5653.1 3992.7 4009.5 4026.4 4027.5 4042.5 5773.7 5921.1 5923.4 5933.9 5937.9 4138.7 4160.7 4167.5 4167.6 4176.0 4224.1 4235.9 4236.0 4243.5 4246.6 4710.3 4749.4 4804.3 4826.5 4827.4 5636.3 5661.0 5680.4 5700.5 5711.8 1459.4 1473.8 1477.6 1478.7 1482.5 921.7 961.5 968.9 1010.8 1024.4 4878.5 4916.4 4922.1 4938.2 4940.0 5718.6 5769.7 5772.7 5777.2 5782.2 4845.3 4932.4 4953.8 4966.2 4974.9 3102.8 3106.8 3109.6 3112.2 3151.1 5401.7 5406.4 5414.9 5440.9 5445.0 5717.0 5887.9 5931.2 5952.8 5953.9 5409.6 5425.1 5432.2 5436.0 5439.2 5584.1 5737.7 5777.1 5784.3 5800.3 5691.8 5716.3 5717.9 5719.0 5735.9 5441.9 5444.9 5454.9 5462.0 5465.2 3836.7 4038.1 4046.4 4173.7 4177.6 5859.3 5864.2 5884.2 5886.9 5898.8 5657.9 5673.8 5681.8 5701.8 5704.9 5494.0 5642.4 5649.8 5650.1 5658.5 5340.0 5559.6 5567.1 5576.7 5576.9 5498.1 5668.9 5732.7 5742.1 5756.5 5518.9 5551.5 5583.4 5597.7 5617.3 14:14:58 INFO - PROCESS | 499 | 14:14:58 INFO - PROCESS | 499 | [#5] yui.html Cycles:180 Average:12107.92 Median:604.16 stddev:13772.52 (2279.6%) stddev-sans-first:13784.68 14:14:58 INFO - PROCESS | 499 | Values: 735.4 770.4 780.9 782.6 800.7 11372.8 11745.1 11942.8 11943.2 12004.0 11469.7 11668.7 11685.0 11885.8 11982.4 635.3 795.8 811.3 823.4 824.7 806.1 806.9 808.5 809.4 811.6 841.7 847.0 849.1 849.9 852.0 838.1 841.1 842.1 842.6 843.9 618.4 620.4 623.8 624.5 624.5 12085.2 12104.0 12105.7 12150.0 12153.8 12880.0 12922.4 13009.9 13103.7 13262.0 9943.2 10071.6 10077.4 10144.5 10371.9 3331.2 3352.8 3418.4 3421.9 3422.9 42974.4 43479.8 43604.6 43619.8 43785.0 9584.6 9755.0 9835.5 9842.5 9886.7 16678.4 16967.7 16991.0 17014.0 17046.7 6785.0 6790.0 6876.7 7055.9 7131.9 3665.0 3725.8 3731.7 3766.6 3876.1 2860.8 3029.6 3031.8 3033.1 3039.6 539.4 545.5 549.9 552.7 554.6 565.9 577.5 600.0 608.3 626.4 7171.6 7462.9 7562.7 7581.2 7674.3 598.2 629.0 629.5 634.5 639.0 3606.4 3664.8 3710.3 3710.7 3770.0 49452.0 49885.0 49936.5 49982.3 50047.5 43359.6 44491.1 44558.3 44688.6 45176.0 39620.0 40765.6 40993.8 41496.6 41841.8 7248.3 7262.1 7327.8 7379.6 7438.7 28446.0 28614.4 28689.4 29166.6 29309.7 34194.3 36443.6 36480.0 36820.4 37593.2 9316.4 9493.2 9548.5 9586.7 9913.9 9748.1 9761.4 9985.8 10001.7 10135.8 8770.7 8872.5 8940.4 9007.4 9163.0 9698.8 9718.0 9779.8 9785.6 10217.5 8906.2 9125.1 9147.3 9293.1 9430.9 8492.9 8720.1 8865.6 8914.5 8934.2 7963.8 8083.3 8117.8 8276.4 8376.8 14:14:58 INFO - PROCESS | 499 | -------- Summary: end -------- 14:14:58 INFO - PROCESS | 499 | 14:14:59 INFO - TEST-INFO | 499: exit 0 14:14:59 INFO - TEST-OK | dromaeo_css | took 1116599ms 14:14:59 INFO - TEST-START | kraken 14:14:59 INFO - operating with platform_type : linux_ 14:14:59 INFO - Initialising browser for kraken test... 14:14:59 INFO - TEST-INFO | started process 739 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOHDcLr/profile http://localhost:34451/getInfo.html) 14:15:03 INFO - PROCESS | 739 | 14:15:03 INFO - PROCESS | 739 | (process:809): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:15:03 INFO - PROCESS | 739 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 14:15:04 INFO - PROCESS | 739 | __metrics Screen width/height:1600/1200 14:15:04 INFO - PROCESS | 739 | colorDepth:24 14:15:04 INFO - PROCESS | 739 | Browser inner width/height: 1024/697 14:15:04 INFO - PROCESS | 739 | __metrics 14:15:05 ERROR - PROCESS | 739 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 14:15:05 INFO - TEST-INFO | 739: exit 0 14:15:05 INFO - Browser initialized. 14:15:05 INFO - Running cycle 1/1 for kraken test... 14:15:05 INFO - TEST-INFO | started process 864 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOHDcLr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:15:08 INFO - PROCESS | 864 | 14:15:08 INFO - PROCESS | 864 | (process:926): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:15:18 INFO - PROCESS | 864 | RSS: Main: 164663296 14:15:18 INFO - PROCESS | 864 | 14:15:20 INFO - PROCESS | 864 | Cycle 1(1): loaded http://localhost:34451/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34451/tests/kraken/driver.html?testName=audio-beat-detection) 14:15:21 INFO - PROCESS | 864 | RSS: Main: 169107456 14:15:21 INFO - PROCESS | 864 | 14:15:24 INFO - PROCESS | 864 | Cycle 1(1): loaded http://localhost:34451/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34451/tests/kraken/driver.html?testName=audio-dft) 14:15:25 INFO - PROCESS | 864 | RSS: Main: 172036096 14:15:25 INFO - PROCESS | 864 | 14:15:27 INFO - PROCESS | 864 | Cycle 1(1): loaded http://localhost:34451/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34451/tests/kraken/driver.html?testName=audio-fft) 14:15:28 INFO - PROCESS | 864 | RSS: Main: 162598912 14:15:28 INFO - PROCESS | 864 | 14:15:30 INFO - PROCESS | 864 | Cycle 1(1): loaded http://localhost:34451/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34451/tests/kraken/driver.html?testName=audio-oscillator) 14:15:31 INFO - PROCESS | 864 | RSS: Main: 162447360 14:15:31 INFO - PROCESS | 864 | 14:15:33 INFO - PROCESS | 864 | Cycle 1(1): loaded http://localhost:34451/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34451/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:15:34 INFO - PROCESS | 864 | RSS: Main: 163962880 14:15:34 INFO - PROCESS | 864 | 14:15:37 INFO - PROCESS | 864 | Cycle 1(1): loaded http://localhost:34451/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34451/tests/kraken/driver.html?testName=imaging-darkroom) 14:15:38 INFO - PROCESS | 864 | RSS: Main: 164196352 14:15:38 INFO - PROCESS | 864 | 14:15:41 INFO - PROCESS | 864 | Cycle 1(1): loaded http://localhost:34451/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34451/tests/kraken/driver.html?testName=imaging-desaturate) 14:15:42 INFO - PROCESS | 864 | RSS: Main: 163500032 14:15:42 INFO - PROCESS | 864 | 14:15:45 INFO - PROCESS | 864 | Cycle 1(1): loaded http://localhost:34451/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34451/tests/kraken/driver.html?testName=json-parse-financial) 14:15:45 INFO - PROCESS | 864 | RSS: Main: 164323328 14:15:45 INFO - PROCESS | 864 | 14:15:47 INFO - PROCESS | 864 | Cycle 1(1): loaded http://localhost:34451/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34451/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:15:48 INFO - PROCESS | 864 | RSS: Main: 164945920 14:15:48 INFO - PROCESS | 864 | 14:15:50 INFO - PROCESS | 864 | Cycle 1(1): loaded http://localhost:34451/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34451/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:15:50 INFO - PROCESS | 864 | RSS: Main: 164896768 14:15:50 INFO - PROCESS | 864 | 14:15:52 INFO - PROCESS | 864 | Cycle 1(1): loaded http://localhost:34451/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34451/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:15:53 INFO - PROCESS | 864 | RSS: Main: 165060608 14:15:53 INFO - PROCESS | 864 | 14:15:56 INFO - PROCESS | 864 | Cycle 1(1): loaded http://localhost:34451/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34451/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:15:57 INFO - PROCESS | 864 | RSS: Main: 165462016 14:15:57 INFO - PROCESS | 864 | 14:16:00 INFO - PROCESS | 864 | Cycle 1(1): loaded http://localhost:34451/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34451/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:16:00 INFO - PROCESS | 864 | RSS: Main: 165220352 14:16:00 INFO - PROCESS | 864 | 14:16:02 INFO - PROCESS | 864 | Cycle 1(1): loaded http://localhost:34451/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34451/tests/kraken/driver.html?testName=ai-astar) 14:16:02 INFO - PROCESS | 864 | RSS: Main: 166948864 14:16:02 INFO - PROCESS | 864 | 14:16:02 INFO - PROCESS | 864 | __start_tp_report 14:16:02 INFO - PROCESS | 864 | _x_x_mozilla_page_load 14:16:02 INFO - PROCESS | 864 | _x_x_mozilla_page_load_details 14:16:02 INFO - PROCESS | 864 | |i|pagename|runs| 14:16:02 INFO - PROCESS | 864 | |0;ai-astar;114;106;113;113;115;128;114;115;111;112 14:16:02 INFO - PROCESS | 864 | |1;audio-beat-detection;154;142;158;193;138;170;167;136;182;134 14:16:02 INFO - PROCESS | 864 | |2;audio-dft;164;165;165;168;169;163;164;165;166;164 14:16:02 INFO - PROCESS | 864 | |3;audio-fft;78;77;74;157;75;83;77;86;158;76 14:16:02 INFO - PROCESS | 864 | |4;audio-oscillator;95;96;147;95;94;94;143;93;94;133 14:16:02 INFO - PROCESS | 864 | |5;imaging-gaussian-blur;117;118;118;117;118;118;118;118;118;118 14:16:02 INFO - PROCESS | 864 | |6;imaging-darkroom;147;147;147;148;147;146;148;147;148;147 14:16:02 INFO - PROCESS | 864 | |7;imaging-desaturate;95;98;96;96;96;96;97;96;96;96 14:16:02 INFO - PROCESS | 864 | |8;json-parse-financial;69;68;66;68;69;67;70;84;65;66 14:16:02 INFO - PROCESS | 864 | |9;json-stringify-tinderbox;64;66;65;65;65;66;65;66;66;66 14:16:02 INFO - PROCESS | 864 | |10;stanford-crypto-aes;86;85;84;87;85;86;86;87;85;87 14:16:02 INFO - PROCESS | 864 | |11;stanford-crypto-ccm;139;144;142;137;135;141;141;140;172;143 14:16:02 INFO - PROCESS | 864 | |12;stanford-crypto-pbkdf2;183;175;177;175;177;172;171;174;173;179 14:16:02 INFO - PROCESS | 864 | |13;stanford-crypto-sha256-iterative;78;76;74;72;73;72;72;73;72;73 14:16:02 INFO - PROCESS | 864 | __end_tp_report 14:16:02 INFO - PROCESS | 864 | __start_cc_report 14:16:02 INFO - PROCESS | 864 | _x_x_mozilla_cycle_collect,894 14:16:02 INFO - PROCESS | 864 | __end_cc_report 14:16:02 INFO - PROCESS | 864 | __startTimestamp1460668562782__endTimestamp 14:16:02 INFO - PROCESS | 864 | 14:16:02 INFO - PROCESS | 864 | ------- Summary: start ------- 14:16:02 INFO - PROCESS | 864 | Number of tests: 14 14:16:02 INFO - PROCESS | 864 | 14:16:02 INFO - PROCESS | 864 | [#0] ai-astar Cycles:10 Average:114.10 Median:114.00 stddev:5.55 (4.9%) stddev-sans-first:5.88 14:16:02 INFO - PROCESS | 864 | Values: 114.0 106.0 113.0 113.0 115.0 128.0 114.0 115.0 111.0 112.0 14:16:02 INFO - PROCESS | 864 | 14:16:02 INFO - PROCESS | 864 | [#1] audio-beat-detection Cycles:10 Average:157.40 Median:162.50 stddev:20.42 (12.6%) stddev-sans-first:21.63 14:16:02 INFO - PROCESS | 864 | Values: 154.0 142.0 158.0 193.0 138.0 170.0 167.0 136.0 182.0 134.0 14:16:02 INFO - PROCESS | 864 | 14:16:02 INFO - PROCESS | 864 | [#2] audio-dft Cycles:10 Average:165.30 Median:165.00 stddev:1.89 (1.1%) stddev-sans-first:1.94 14:16:02 INFO - PROCESS | 864 | Values: 164.0 165.0 165.0 168.0 169.0 163.0 164.0 165.0 166.0 164.0 14:16:02 INFO - PROCESS | 864 | 14:16:02 INFO - PROCESS | 864 | [#3] audio-fft Cycles:10 Average:94.10 Median:77.00 stddev:33.61 (43.7%) stddev-sans-first:35.14 14:16:02 INFO - PROCESS | 864 | Values: 78.0 77.0 74.0 157.0 75.0 83.0 77.0 86.0 158.0 76.0 14:16:02 INFO - PROCESS | 864 | 14:16:02 INFO - PROCESS | 864 | [#4] audio-oscillator Cycles:10 Average:108.40 Median:94.00 stddev:22.77 (24.2%) stddev-sans-first:23.62 14:16:02 INFO - PROCESS | 864 | Values: 95.0 96.0 147.0 95.0 94.0 94.0 143.0 93.0 94.0 133.0 14:16:02 INFO - PROCESS | 864 | 14:16:02 INFO - PROCESS | 864 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 14:16:02 INFO - PROCESS | 864 | Values: 117.0 118.0 118.0 117.0 118.0 118.0 118.0 118.0 118.0 118.0 14:16:02 INFO - PROCESS | 864 | 14:16:02 INFO - PROCESS | 864 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 14:16:02 INFO - PROCESS | 864 | Values: 147.0 147.0 147.0 148.0 147.0 146.0 148.0 147.0 148.0 147.0 14:16:02 INFO - PROCESS | 864 | 14:16:02 INFO - PROCESS | 864 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.71 14:16:02 INFO - PROCESS | 864 | Values: 95.0 98.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 14:16:02 INFO - PROCESS | 864 | 14:16:02 INFO - PROCESS | 864 | [#8] json-parse-financial Cycles:10 Average:69.20 Median:68.50 stddev:5.43 (7.9%) stddev-sans-first:5.76 14:16:02 INFO - PROCESS | 864 | Values: 69.0 68.0 66.0 68.0 69.0 67.0 70.0 84.0 65.0 66.0 14:16:02 INFO - PROCESS | 864 | 14:16:02 INFO - PROCESS | 864 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.53 14:16:02 INFO - PROCESS | 864 | Values: 64.0 66.0 65.0 65.0 65.0 66.0 65.0 66.0 66.0 66.0 14:16:02 INFO - PROCESS | 864 | 14:16:02 INFO - PROCESS | 864 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:86.00 stddev:1.03 (1.2%) stddev-sans-first:1.09 14:16:02 INFO - PROCESS | 864 | Values: 86.0 85.0 84.0 87.0 85.0 86.0 86.0 87.0 85.0 87.0 14:16:02 INFO - PROCESS | 864 | 14:16:02 INFO - PROCESS | 864 | [#11] stanford-crypto-ccm Cycles:10 Average:143.40 Median:141.50 stddev:10.41 (7.4%) stddev-sans-first:10.91 14:16:02 INFO - PROCESS | 864 | Values: 139.0 144.0 142.0 137.0 135.0 141.0 141.0 140.0 172.0 143.0 14:16:02 INFO - PROCESS | 864 | 14:16:02 INFO - PROCESS | 864 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.60 Median:176.00 stddev:3.57 (2.0%) stddev-sans-first:2.59 14:16:02 INFO - PROCESS | 864 | Values: 183.0 175.0 177.0 175.0 177.0 172.0 171.0 174.0 173.0 179.0 14:16:02 INFO - PROCESS | 864 | 14:16:02 INFO - PROCESS | 864 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.50 Median:73.00 stddev:2.01 (2.8%) stddev-sans-first:1.32 14:16:02 INFO - PROCESS | 864 | Values: 78.0 76.0 74.0 72.0 73.0 72.0 72.0 73.0 72.0 73.0 14:16:02 INFO - PROCESS | 864 | -------- Summary: end -------- 14:16:02 INFO - PROCESS | 864 | 14:16:03 INFO - TEST-INFO | 864: exit 0 14:16:03 INFO - TEST-OK | kraken | took 64217ms 14:16:03 INFO - SUITE-END | took 1180s 14:16:03 INFO - Completed test suite (00:19:40) 14:16:03 INFO - javascript benchmark 14:16:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2611.08611985805, 2716.3480764616484, 2755.393813361061, 2760.9171724848247, 2767.7647399971, 4823.083614113316, 4826.0, 4829.686070405422, 4831.323614693937, 4908.8281910133155, 4683.250679891218, 4755.286706993953, 4766.5471780180915, 4769.260764581487, 4774.474807771142, 4371.715838470489, 4426.358178064179, 4490.169318676056, 4561.7491037992895, 4573.382593349888, 4493.752843593601, 4542.909141817162, 4543.704659197141, 4548.317752337143, 4558.61251793598, 4467.15124126415, 4470.441194850644, 4515.435570553681, 4529.932051019237, 4530.954690453103, 4375.431193944799, 4474.105178964188, 4486.080353527519, 4509.571590698911, 4513.638908887281, 4401.515833258339, 4402.735835849827, 4407.581279778416, 4418.3593378960195, 4445.911081778347, 4599.70101943376, 4682.789274482657, 4698.271767875985, 4706.1999460091865, 4767.261074533453, 5167.379914410257, 5175.948240517584, 5176.896462070775, 5185.274061631375, 5201.947980520222, 5128.9230661540105, 5155.458676838953, 5169.896602067975, 5202.973985130088, 5215.061288967984, 4720.575148236675, 4797.64017698674, 4800.975995120002, 4808.206645903421, 4869.415670119537, 5259.605529585297, 5270.5256526912, 5272.393674727456, 5300.893982120336, 5315.760790764425, 5064.18972964324, 5077.1876499759865, 5083.974580127076, 5084.542391184811, 5098.668586541863, 5105.489451054939, 5113.565346945476, 5157.819476318311, 5185.274061631375, 5205.7917683293, 5182.740862956837, 5190.377154741455, 5219.138842091088, 5221.13851214553, 5227.26818245446, 5156.458571849902, 5170.870728231825, 5178.223266509978, 5187.740612969336, 5226.242194881721, 4226.57734226581, 4236.385724069993, 4290.613844753987, 4293.720908140961, 4363.38912552243, 3782.8486860525272, 3801.961980380216, 3803.220339830328, 3835.810898621436, 3839.232153569297, 4499.6400287976885, 4519.570640789119, 4524.6380289576755, 4554.817807287738, 4567.657425693086, 5143.228515722597, 5177.0, 5244.921326180111, 5254.894902101936, 5257.263983042377, 4461.687681862239, 4484.05834774701, 4498.347739577743, 4499.4150760400935, 4563.931541026887, 4548.454185497695, 4618.769061546909, 4622.0, 4635.536446355405, 4672.696274742131, 4869.269609558594, 4892.510748925079, 4901.3138160658245, 4917.483664215206, 4938.283948827472, 5172.353455818023, 5174.301469301596, 5227.634065615523, 5232.215167724872, 5255.684658920477, 4727.763611819464, 4795.616350692006, 4870.902581948412, 4881.58506526935, 4905.018996200845, 5122.74386280677, 5125.948740512547, 5162.406323272871, 5165.741712914264, 5197.740112994411, 5215.348081489814, 5221.686698798084, 5231.0, 5246.737663116753, 5282.920756188737, 4927.531884470969, 5039.420466646383, 5053.84838454847, 5069.340985671839, 5123.001014802077, 5011.248312753116, 5027.145385284437, 5039.596832253337, 5048.116579598629, 5076.847694569169, 4917.852464426073, 4961.42943561495, 4966.106100901872, 4974.651774375759, 5028.0, 4935.235038569028, 5042.949570504248, 5114.053900028507, 5114.616403769806, 5134.10153223177, 4839.564439200489, 4879.829205977774, 4934.506549345037, 4943.134951383566, 4989.151844186425], "value": 4750.898014722916, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.0334689395262, 600.9849753756156, 607.9848003799905, 620.550101176647, 635.9364063593644, 32677.346453070924, 33746.66253337469, 33799.83100084502, 33909.830450847745, 33998.32003359931, 37547.4367884482, 37981.62018379816, 38081.809590952005, 38283.617163828356, 38335.233295334074, 7612.961935190317, 7811.960940195291, 7841.6079196040255, 7843.764687059397, 7853.057633084038, 7656.693732250703, 7846.176151504095, 7847.568383738892, 7850.646720897545, 7865.724699635514, 7734.922650773477, 7842.215778422169, 7842.921570784305, 7845.686172553091, 7875.684972601118, 7756.108047574517, 7797.57113358765, 7813.687452501893, 7833.804154896145, 7840.607969601497, 7752.5348479091435, 7812.218778122199, 7853.607319634052, 7868.803279918048, 7869.763907082796, 31791.20521986946, 34075.6592434075, 34612.82693586516, 34652.48021279683, 34726.6527334726, 2869.1679412970216, 2932.178989882836, 2970.1535062507082, 3191.952120718191, 3411.778234414755, 24389.26832195037, 24604.261872143863, 24621.0, 24812.751872481404, 24971.126010589724, 3341.9498707519406, 3343.9498407523906, 3376.375370556455, 3481.669241422061, 3487.5466189395215, 150199.0, 150600.0, 150814.24592877075, 151412.0, 152465.23767381092, 32489.51265731016, 32622.67377326244, 32766.0, 32815.179620509676, 32870.342593148, 33751.66248337485, 56790.0, 58032.709836451395, 58123.0, 58216.0, 14962.177080260473, 14981.40074397012, 15077.396904123932, 15230.619234519005, 15246.23768811555, 11379.715507112389, 11599.88400116005, 11610.6516804496, 11633.825492617618, 11650.766984660258, 18471.53821154455, 18723.063846807607, 18835.152418141217, 18866.434006979813, 18876.811231887506, 6947.305269473012, 7020.192677842011, 7085.751998680124, 7246.166690830517, 7272.381847543018, 895.9372843900865, 947.1712251779693, 1013.2755080117752, 1028.711960651019, 1058.4072919165292, 28307.433851322858, 28411.147665570064, 28902.0, 29058.854705726335, 29110.0, 1006.6074231049896, 1053.6891616973012, 1076.838474228872, 1103.1340397787699, 1124.8425220469142, 14900.776488352683, 15164.545063647887, 15402.537923862303, 15536.223188840513, 15537.30082146306, 158736.0, 159160.0, 159565.2021739884, 159743.0, 160554.0, 49408.25887611689, 49497.25754113691, 50013.24980125301, 50124.0, 50187.0, 1196.8743281955444, 1230.1757822259108, 1259.9164718342217, 1277.974440511203, 1286.948522059107, 26984.190474285802, 28169.295767605156, 28383.574246385906, 28625.42749144964, 29007.564886526296, 42766.786166068974, 42943.7852810734, 43489.56510434855, 43501.69494915158, 43538.782306088266, 316955.0, 318062.0, 318617.0, 318728.0, 318752.0, 25368.11211607585, 25589.104381346562, 40958.79520602378, 42230.577694222666, 42382.57617423786, 39042.414363783995, 39437.6056239434, 40273.39589906095, 40944.0, 41036.0, 34399.31201375908, 35340.469892951114, 35421.0, 35442.291154177285, 35734.64265357313, 33978.8301058503, 34570.13574660553, 34658.133546661535, 34823.825880870434, 35072.29855402929, 34767.82616086904, 34912.30175396529, 38063.61936380601, 38907.41638875363, 38980.80509597434, 29240.26899327534, 31319.21701957469, 31842.84078579592, 31962.36075278435, 31964.520532192502, 24976.875115624305, 25145.0, 25179.370515737253, 25243.87378063098, 25411.618825718], "value": 16732.07835680366, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.7682636765206, 376.1649138911615, 379.27558363525674, 384.3120813743399, 392.9862454814082, 15715.842841571595, 16188.27152778125, 16977.91511042443, 17028.318867245325, 17063.57341066474, 12017.339046352447, 15306.464273750422, 16029.278682459288, 16072.116033618146, 16074.919625401857, 4719.858404247878, 4850.563449289563, 4896.951030489685, 4899.265110233458, 4907.067657145131, 3479.373712731707, 4739.36018637483, 5165.896682066356, 5469.0, 5495.450454954493, 5444.673319600817, 5455.399906010336, 5471.644343117705, 5475.917861232085, 5484.149956756709, 5290.656107353029, 5347.0, 5384.273123128406, 5401.513863752242, 5429.864253393657, 5303.390110137345, 5328.227407025998, 5341.599380046512, 5344.118220493614, 5348.277982472356, 17708.645827083514, 19229.326973555857, 20036.89981550083, 20090.0, 20092.0, 1917.5781328107794, 2011.3965810257012, 2114.851960362775, 2292.518571100071, 2402.3393566769105, 8601.655933762642, 9180.127887850711, 9207.17135457812, 9274.118958698913, 9533.666321678777, 1589.507252751639, 1699.167407970098, 1713.6744018636418, 1725.9050752208623, 1736.862355157374, 59818.40181598172, 59996.40003599952, 60132.69933650347, 60179.79640407211, 60678.69660651713, 8268.2558569729, 8772.605232764541, 8885.06706795777, 8891.599878005376, 9017.09829017093, 11708.531658733555, 11745.765084698258, 11808.232464889754, 11811.822822657667, 11859.229150105215, 6792.626405547742, 6819.0, 6830.8633827324165, 7018.438524917994, 7028.648567571601, 6724.865502690017, 6765.221999470025, 6815.863682726417, 6901.689423975933, 6937.479689023344, 3728.254349130185, 3744.513213282256, 3764.228333191689, 3778.471014058034, 3813.3517302058717, 1785.7232129020022, 1808.0257975630016, 1859.8140185981565, 1860.7860096089123, 1863.4316533457154, 916.8166366726681, 931.3852857114272, 949.0035462764071, 964.5418426247617, 973.9724590556889, 15884.364625415084, 16464.753028704577, 16623.168841557872, 16689.66620667604, 16889.324427023028, 895.2524641923936, 905.651324240159, 906.3655441191061, 916.8991410944791, 936.1060187520901, 9348.626054957726, 9475.384100033476, 9545.713628591153, 9563.426194428217, 9622.759431014281, 401697.0, 402562.0, 407977.0, 408150.0, 408416.0, 77782.0, 80180.0, 80775.59612201901, 80786.0, 81078.59460702659, 961.2310151878609, 967.6032826541084, 997.7605374710017, 1006.2704539209014, 1014.4927536231884, 14817.185054822088, 14872.479463218735, 14984.850151498345, 15155.166465844484, 15422.537323880302, 31952.840235799602, 32857.05715314177, 34369.82815085909, 34576.48135277923, 34665.0, 43099.0, 47707.284390733475, 47953.280700790216, 48210.758946205046, 48458.75770621125, 5006.0, 6845.657717114024, 7466.029416175862, 7584.582847943416, 7884.250996155356, 10292.279540432099, 11417.37204453763, 11574.421278935852, 11640.0, 11743.706407339885, 9829.901700982899, 10008.39949603026, 10112.342697724624, 10278.691639250834, 10464.581416743245, 9610.183134433652, 9855.260855436014, 10025.849612255675, 10312.48437578133, 10334.741631459274, 10170.135538479311, 10202.795944081225, 10253.846192306972, 10444.843327350247, 10449.738756530844, 7473.43949203801, 7537.0, 7565.6973721050545, 7700.691972321269, 7738.264864837832, 7790.61046947639, 9833.950830245803, 10298.897011029794, 10422.21833362516, 10611.31026483276], "value": 7981.481869171331, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1417.4471955937183, 1490.731668299706, 1609.3482139733412, 1723.6983527882617, 1789.5615574184326, 6968.233494315621, 7596.9744084548565, 7668.309852113309, 7911.0506739191305, 7919.920800791991, 7716.2669546393145, 7723.150453450116, 7749.496282741632, 7792.220777922205, 7800.843983120349, 2182.0, 2217.2572188316853, 2220.966685499719, 2222.411061068818, 2222.48882756966, 2188.485705859122, 2193.2652561391874, 2204.966925496111, 2205.40454077399, 2205.8235341172667, 2147.967780483294, 2179.3461961411595, 2190.408589680785, 2193.8683678979232, 2197.549502352022, 2136.070809197996, 2143.7534683511362, 2144.5389241313114, 2145.957080858374, 2154.6229409853213, 2143.2820005298245, 2180.3349978256783, 2181.727284089489, 2185.191479152708, 2188.2231807708354, 7842.568658723768, 7948.364130869517, 7988.041435027776, 7999.0, 8010.839783204362, 4524.524924882873, 4693.084848454553, 4711.599514041311, 4713.080949214905, 4722.409698787652, 2971.5691224772286, 2986.3280761828632, 3045.817250964927, 3061.8162910225456, 3100.085474784944, 975.687779910429, 1001.7195185348114, 1011.8482227665835, 1016.547636301846, 1045.8117538843005, 10542.367457952547, 10604.257701960943, 10623.097036751886, 10662.0, 10683.679489615324, 4144.91710165801, 4148.688848336386, 4343.847965321199, 4365.781710914442, 4370.2570563004365, 8860.246879015227, 8952.194302512806, 8987.427200240063, 9023.729288121367, 9039.367244292967, 4558.794854231567, 4562.771861406916, 4577.29051996941, 4587.885302867388, 4590.67865249436, 3578.928421431609, 4174.770387628649, 4197.664186865043, 4216.304309788912, 4294.0, 3651.8904432867057, 3660.5424321959754, 3719.7210209234418, 3753.174301653632, 3766.7928263945196, 1214.7874122028609, 1223.687959570304, 1232.7226374065942, 1233.463443402123, 1240.3736113262744, 784.6273020315305, 806.2139414071233, 827.9503229806111, 935.3592788939599, 947.5499137909438, 5330.120530112566, 5334.413214546396, 5571.749271282802, 5711.628744131618, 5736.483716465538, 822.1901427094307, 921.5806807902388, 932.6828878181451, 948.6502260339661, 955.4458414119932, 3616.1863580694135, 3798.164403831153, 3857.286402015636, 3886.0867696091395, 3895.668868146183, 9173.908260917438, 9555.140037396668, 9606.759831004281, 9621.27840411958, 9636.373635713657, 9829.21366290695, 9866.802663946824, 9899.455529945779, 9937.602495900082, 9940.353876997971, 7320.743773967885, 7406.629668516553, 7461.0, 7494.5503269803985, 7550.244975502515, 5439.972800135974, 5573.804916827891, 5695.8860822784145, 5860.594610719004, 5902.5277977762535, 8878.600462979051, 9081.182693557612, 9102.180803727697, 9141.405808622418, 9167.862482062641, 8971.596278167628, 9123.133302336268, 9152.352576536021, 9165.587548560197, 9356.391834530734, 6124.969375153096, 6566.6388348641285, 6718.529702920749, 6815.42068924147, 6831.077804496329, 7536.397088233038, 7537.962310188634, 7604.42966777505, 7624.923750762421, 7633.69465221385, 6653.0, 6740.460763138839, 6768.2216545097945, 6822.556533825285, 6856.588604683735, 6776.356246156607, 6815.625140617115, 6852.486063545154, 6964.512484126062, 6969.651517424007, 6571.507136964651, 6601.702923368556, 6614.6361950093205, 6679.532432729662, 6709.463242940651, 4934.358533390637, 4948.406191257072, 4952.925706114339, 4956.950430495649, 5017.598592112549, 5005.424376196784, 5038.396329909333, 5127.230915362726, 5134.281200631989, 5134.512221338967], "value": 4245.536350295805, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.5863189905275, 322.5130053619035, 324.10062077734284, 328.6664036003455, 330.8378894341773, 5298.337707786527, 5362.597805164619, 5367.7584508697055, 5402.486763757442, 5429.945700542993, 5336.119540275859, 5337.370588000158, 5357.276767636368, 5365.7585408656605, 5372.892542149155, 3941.1329507508303, 4038.5153781546255, 4172.08214192877, 4189.392538081976, 4195.706300558947, 4172.624463798257, 4182.53992060873, 4199.076203235299, 4199.475065616798, 4201.474815648044, 4144.336906095025, 4155.31437312843, 4165.812538435777, 4174.436451079096, 4175.457190565222, 4014.197160567898, 4120.464339635858, 4130.421740956269, 4133.689973252003, 4137.668986481074, 3633.909152271188, 3641.890743277706, 3647.0, 3649.9817500912327, 3657.414813629833, 5120.820771273025, 5130.743462826844, 5167.560757335631, 5168.9224661630105, 5169.069567477853, 4651.441826980784, 4702.553257440538, 4755.262934245197, 4790.520947905216, 4824.807007719687, 5585.636933599303, 5600.271964644611, 5612.971935140339, 5649.180868774046, 5653.123765816305, 3992.740471869319, 4009.4787677601726, 4026.396040593905, 4027.516697996259, 4042.454268673721, 5773.682447465388, 5921.141434491975, 5923.407659234085, 5933.851653708692, 5937.9406205937385, 4138.730982486129, 4160.687948403821, 4167.499900011957, 4167.562405947332, 4176.0395109125075, 4224.070704445017, 4235.9364609530885, 4235.957640423557, 4243.511996120424, 4246.554111818215, 4710.269908164171, 4749.3588365570895, 4804.294475461231, 4826.541478559531, 4827.42070951481, 5636.323641163005, 5661.0, 5680.4319568042865, 5700.515456186271, 5711.828645140652, 1459.3797636004867, 1473.8378778334375, 1477.5567329801017, 1478.6525166585843, 1482.5330021043337, 921.741912264567, 961.5288508630861, 968.8885778135464, 1010.8433192855119, 1024.4467987286782, 4878.512148785093, 4916.410030796327, 4922.1140194765285, 4938.160512712848, 4939.987302602958, 5718.599698021182, 5769.740361683735, 5772.740226689809, 5777.220075289866, 5782.219400380979, 4845.3216549683075, 4932.4081110267, 4953.777080031407, 4966.205407134841, 4974.875628109254, 3102.844857757103, 3106.782525223213, 3109.626844778641, 3112.159716876476, 3151.0861850063684, 5401.7299135043095, 5406.378266499403, 5414.891702166014, 5440.891182176334, 5444.972775136099, 5716.979727550135, 5887.941120588825, 5931.228940237742, 5952.839196356756, 5953.910691339634, 5409.6213265071065, 5425.13197888336, 5432.158015507603, 5436.021516127135, 5439.184122381754, 5584.106542953108, 5737.684427356536, 5777.133429985536, 5784.2769653793275, 5800.332961709458, 5691.8292451226525, 5716.342620598684, 5717.942820571741, 5719.0, 5735.8852822944145, 5441.891162176655, 5444.863878403072, 5454.91817622728, 5461.972690136524, 5465.207544906046, 3836.6930645548846, 4038.0914294283552, 4046.3728122141115, 4173.707840451139, 4177.644900183518, 5859.326177489473, 5864.208331875142, 5884.235049443545, 5886.852828679146, 5898.793542226002, 5657.886842263214, 5673.8297851064535, 5681.77272909079, 5701.771929122789, 5704.914426283692, 5494.028338565491, 5642.351129620146, 5649.7740090397565, 5650.0959846424375, 5658.519025882846, 5339.973300133474, 5559.63862348946, 5567.137093750475, 5576.749046293007, 5576.888462230814, 5498.147787093007, 5668.914966275592, 5732.684702341411, 5742.109972954198, 5756.481916627524, 5518.862028449321, 5551.472610102034, 5583.35791383996, 5597.692126933058, 5617.269754931996], "value": 4246.335080889506, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [735.4226931858491, 770.3875419041865, 780.9297163255305, 782.5578548120311, 800.7037396163421, 11372.829407558893, 11745.119116066297, 11942.820857687131, 11943.163978521507, 12004.0, 11469.713257168574, 11668.708282292946, 11685.0, 11885.821712674317, 11982.40087995601, 635.3043417457899, 795.7652492514723, 811.2658044469764, 823.4153750836913, 824.6577670266832, 806.1454857850667, 806.9475484093545, 808.5431731071925, 809.4212637963855, 811.5577010529246, 841.6633346661323, 846.9576521173948, 849.1126772522729, 849.8682704180862, 851.9574021298941, 838.0571856661256, 841.1210285251926, 842.1368097699846, 842.6334544473174, 843.8649816029467, 618.3569088148321, 620.3765215957933, 623.8440389902524, 624.4629618528062, 624.5347216323868, 12085.15403921726, 12104.0, 12105.697357566043, 12150.0, 12153.756924861453, 12880.0, 12922.353882305848, 13009.934950325187, 13103.737925241538, 13262.0, 9943.204543636564, 10071.647492337734, 10077.395356278646, 10144.492775361203, 10371.948140259326, 3331.2005118771563, 3352.765306428551, 3418.4017796885446, 3421.9315613687836, 3422.9486557701653, 42974.35538466925, 43479.782601086794, 43604.56395436037, 43619.78190109029, 43785.0, 9584.616615335448, 9754.951225243829, 9835.459049752333, 9842.458664773363, 9886.703398898044, 16678.416255431002, 16967.74548381775, 16991.0, 17014.0, 17046.659066818593, 6785.0, 6790.0, 6876.69054892531, 7055.858882822315, 7131.89302160468, 3665.0, 3725.776453412804, 3731.738778285548, 3766.6233376662112, 3876.0503676599415, 2860.7711383089304, 3029.560713696502, 3031.8029328093603, 3033.135556366425, 3039.6352437707174, 539.3851009848776, 545.5281181777813, 549.881775418287, 552.7374497113839, 554.6006875049958, 565.9037963546207, 577.4543056811357, 599.9940000600026, 608.3247595169358, 626.3517259636254, 7171.569705817667, 7462.888056679154, 7562.735304264324, 7581.203973582805, 7674.309312161932, 598.1775059293471, 629.0030301971426, 629.4555209743539, 634.5209366928032, 638.9808305750835, 3606.3688854450365, 3664.798436086041, 3710.2950439416422, 3710.6845918096724, 3769.981150094232, 49452.0, 49885.0, 49936.500634993914, 49982.25026624603, 50047.49952500501, 43359.56640433618, 44491.11017779626, 44558.331625025654, 44688.553114468436, 45176.0, 39620.0, 40765.59234407677, 40993.79503102465, 41496.58503414987, 41841.79079104585, 7248.347648711641, 7262.092238470192, 7327.780166595011, 7379.557226566423, 7438.73964411243, 28446.0, 28614.427711445238, 28689.42621147607, 29166.562501562068, 29309.70690293155, 34194.316113678084, 36443.63556364403, 36480.0, 36820.44769328516, 37593.24813503769, 9316.44101353921, 9493.193078588121, 9548.522573871418, 9586.66446674363, 9913.851292230478, 9748.122668959544, 9761.414315141114, 9985.800283994426, 10001.699949001251, 10135.79728405413, 8770.693025744069, 8872.467651940904, 8940.418872773509, 9007.414518056305, 9162.992070872331, 9698.806023879624, 9717.951410242904, 9779.755506112404, 9785.608575656894, 10217.540210690686, 8906.242969347679, 9125.087491250822, 9147.268218542367, 9293.070692930924, 9430.905690943002, 8492.915070849212, 8720.12798720123, 8865.64537418496, 8914.465132092095, 8934.195922367018, 7963.761087167394, 8083.272505474535, 8117.8376432472205, 8276.379271554537, 8376.790580235544], "value": 5732.751214532515, "unit": "score"}], "name": "dromaeo_css", "value": 6350.288669457506, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 106.0, 113.0, 113.0, 115.0, 128.0, 114.0, 115.0, 111.0, 112.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 142.0, 158.0, 193.0, 138.0, 170.0, 167.0, 136.0, 182.0, 134.0], "value": 157.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 165.0, 168.0, 169.0, 163.0, 164.0, 165.0, 166.0, 164.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 74.0, 157.0, 75.0, 83.0, 77.0, 86.0, 158.0, 76.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 147.0, 95.0, 94.0, 94.0, 143.0, 93.0, 94.0, 133.0], "value": 108.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 147.0, 146.0, 148.0, 147.0, 148.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 98.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 66.0, 68.0, 69.0, 67.0, 70.0, 84.0, 65.0, 66.0], "value": 69.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 65.0, 65.0, 66.0, 65.0, 66.0, 66.0, 66.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 84.0, 87.0, 85.0, 86.0, 86.0, 87.0, 85.0, 87.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 144.0, 142.0, 137.0, 135.0, 141.0, 141.0, 140.0, 172.0, 143.0], "value": 143.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 175.0, 177.0, 175.0, 177.0, 172.0, 171.0, 174.0, 173.0, 179.0], "value": 175.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 74.0, 72.0, 73.0, 72.0, 72.0, 73.0, 72.0, 73.0], "value": 73.5, "unit": "score"}], "name": "kraken", "value": 1613.4, "alertThreshold": 2.0}]} 14:16:04 INFO - Return code: 0 14:16:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:16:04 ERROR - # TBPL SUCCESS # 14:16:04 INFO - Running post-action listener: _resource_record_post_action 14:16:04 INFO - Running post-run listener: _resource_record_post_run 14:16:05 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 530042880; Read time: 0; Write time: 649948 14:16:05 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 233938944; Read time: 0; Write time: 346060 14:16:05 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 296103936; Read time: 0; Write time: 303888 14:16:05 INFO - Running post-run listener: _upload_blobber_files 14:16:05 INFO - Blob upload gear active. 14:16:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:16:05 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 14:16:05 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:16:05 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:16:05 INFO - (blobuploader) - INFO - Open directory for files ... 14:16:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:16:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:16:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:16:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:16:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:16:06 INFO - (blobuploader) - INFO - Done attempting. 14:16:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:16:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:16:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:16:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:16:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:16:07 INFO - (blobuploader) - INFO - Done attempting. 14:16:07 INFO - (blobuploader) - INFO - Iteration through files over. 14:16:07 INFO - Return code: 0 14:16:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:16:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:16:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f022f6030de00d887bde85b226d1f0150c6d2a0adbe0f9c11ac5f8ca4b78a74ce04e764ac41305994204c053a36d3a052702236895bc41c7ba550a1597466bd3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5b3eb3b1aeff8de5c2655bea61212a573fe24c1d41349d92243aec46ee77262102e9ce6c6060ddecac3568fce04e6560b66518dc948a1d87fc1f2baeab46023e"} 14:16:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:16:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:16:07 INFO - Contents: 14:16:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f022f6030de00d887bde85b226d1f0150c6d2a0adbe0f9c11ac5f8ca4b78a74ce04e764ac41305994204c053a36d3a052702236895bc41c7ba550a1597466bd3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5b3eb3b1aeff8de5c2655bea61212a573fe24c1d41349d92243aec46ee77262102e9ce6c6060ddecac3568fce04e6560b66518dc948a1d87fc1f2baeab46023e"} 14:16:07 INFO - Running post-run listener: copy_logs_to_upload_dir 14:16:07 INFO - Copying logs to upload dir... 14:16:07 INFO - mkdir: /builds/slave/test/build/upload/logs 14:16:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.037374 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-04-14 14:16:06.914027) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 14:16:06.918062) ========= 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=14ef55db36f7623abb31b9cf000001d5-1460664761.508680-1226443325 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/Fx-Team-Non-PGO/sha512/f022f6030de00d887bde85b226d1f0150c6d2a0adbe0f9c11ac5f8ca4b78a74ce04e764ac41305994204c053a36d3a052702236895bc41c7ba550a1597466bd3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5b3eb3b1aeff8de5c2655bea61212a573fe24c1d41349d92243aec46ee77262102e9ce6c6060ddecac3568fce04e6560b66518dc948a1d87fc1f2baeab46023e"} build_url:https://queue.taskcluster.net/v1/task/YUAMftqOSXi4jPiCKqiqdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011289 build_url: 'https://queue.taskcluster.net/v1/task/YUAMftqOSXi4jPiCKqiqdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f022f6030de00d887bde85b226d1f0150c6d2a0adbe0f9c11ac5f8ca4b78a74ce04e764ac41305994204c053a36d3a052702236895bc41c7ba550a1597466bd3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5b3eb3b1aeff8de5c2655bea61212a573fe24c1d41349d92243aec46ee77262102e9ce6c6060ddecac3568fce04e6560b66518dc948a1d87fc1f2baeab46023e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 14:16:06.948197) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 14:16:06.948628) ========= 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=14ef55db36f7623abb31b9cf000001d5-1460664761.508680-1226443325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004559 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 14:16:07.032892) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 14:16:07.033247) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 14:16:07.033604) ========= ========= Total master_lag: 0.19 =========