builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-003 starttime: 1464578197.54 results: success (0) buildid: 20160529173010 builduid: 4fa243fee7c2480abdadba39e3dcf958 revision: f59918cf04fa5954101b0274ebf60fb7e11e7a21 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-29 20:16:37.543749) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-29 20:16:37.545437) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-29 20:16:37.546012) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-29 20:16:37.568421) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 20:16:37.568693) ========= 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=7de08804244eb36560b44971000001c3-1464576464.595091-1281982449 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-29 20:16:38-- 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% 94.0M=0s 2016-05-29 20:16:38 (94.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122549 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 20:16:37.705039) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 20:16:37.705366) ========= 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=7de08804244eb36560b44971000001c3-1464576464.595091-1281982449 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020992 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 20:16:37.753984) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-29 20:16:37.754304) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f59918cf04fa5954101b0274ebf60fb7e11e7a21 --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 f59918cf04fa5954101b0274ebf60fb7e11e7a21 --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=7de08804244eb36560b44971000001c3-1464576464.595091-1281982449 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-29 20:16:39,014 truncating revision to first 12 chars 2016-05-29 20:16:39,014 Setting DEBUG logging. 2016-05-29 20:16:39,014 attempt 1/10 2016-05-29 20:16:39,014 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f59918cf04fa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-29 20:16:39,906 unpacking tar archive at: fx-team-f59918cf04fa/testing/mozharness/ program finished with exit code 0 elapsedTime=1.207496 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-29 20:16:38.975069) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-29 20:16:38.975394) ========= script_repo_revision: f59918cf04fa5954101b0274ebf60fb7e11e7a21 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-29 20:16:38.975789) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-29 20:16:38.976053) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-29 20:16:38.989984) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-05-29 20:16:38.990347) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=7de08804244eb36560b44971000001c3-1464576464.595091-1281982449 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:16:40 INFO - MultiFileLogger online at 20160529 20:16:40 in /builds/slave/test 20:16:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:16:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:16:40 INFO - {'append_to_log': False, 20:16:40 INFO - 'base_work_dir': '/builds/slave/test', 20:16:40 INFO - 'blob_upload_branch': 'Fx-Team', 20:16:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:16:40 INFO - 'branch': 'Fx-Team', 20:16:40 INFO - 'buildbot_json_path': 'buildprops.json', 20:16:40 INFO - 'config_files': ('talos/linux_config.py',), 20:16:40 INFO - 'default_actions': ('clobber', 20:16:40 INFO - 'read-buildbot-config', 20:16:40 INFO - 'download-and-extract', 20:16:40 INFO - 'populate-webroot', 20:16:40 INFO - 'create-virtualenv', 20:16:40 INFO - 'install', 20:16:40 INFO - 'run-tests'), 20:16:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:16:40 INFO - 'download_minidump_stackwalk': True, 20:16:40 INFO - 'download_symbols': 'ondemand', 20:16:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:16:40 INFO - 'tooltool.py': '/tools/tooltool.py', 20:16:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:16:40 INFO - '/tools/misc-python/virtualenv.py')}, 20:16:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:16:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:16:40 INFO - 'installer_path': 'installer.exe', 20:16:40 INFO - 'log_level': 'info', 20:16:40 INFO - 'log_name': 'talos', 20:16:40 INFO - 'log_to_console': True, 20:16:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:16:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:16:40 INFO - 'opt_config_files': (), 20:16:40 INFO - 'pip_index': False, 20:16:40 INFO - 'sps_profile': False, 20:16:40 INFO - 'sps_profile_interval': 0, 20:16:40 INFO - 'suite': 'dromaeojs-e10s', 20:16:40 INFO - 'system_bits': '32', 20:16:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:16:40 INFO - 'title': 'talos-linux64-ix-003', 20:16:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:16:40 INFO - 'use_talos_json': True, 20:16:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:16:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:16:40 INFO - 'work_dir': 'build'} 20:16:40 INFO - ##### 20:16:40 INFO - ##### Running clobber step. 20:16:40 INFO - ##### 20:16:40 INFO - Running pre-action listener: _resource_record_pre_action 20:16:40 INFO - Running main action method: clobber 20:16:40 INFO - rmtree: /builds/slave/test/build 20:16:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:16:41 INFO - Running post-action listener: _resource_record_post_action 20:16:41 INFO - ##### 20:16:41 INFO - ##### Finished clobber step (success) 20:16:41 INFO - ##### 20:16:41 INFO - ##### 20:16:41 INFO - ##### Running read-buildbot-config step. 20:16:41 INFO - ##### 20:16:41 INFO - Running pre-action listener: _resource_record_pre_action 20:16:41 INFO - Running main action method: read_buildbot_config 20:16:41 INFO - Using buildbot properties: 20:16:41 INFO - { 20:16:41 INFO - "project": "", 20:16:41 INFO - "product": "firefox", 20:16:41 INFO - "script_repo_revision": "production", 20:16:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 20:16:41 INFO - "repository": "", 20:16:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 20:16:41 INFO - "buildid": "20160529173010", 20:16:41 INFO - "pgo_build": "True", 20:16:41 INFO - "basedir": "/builds/slave/test", 20:16:41 INFO - "buildnumber": 389, 20:16:41 INFO - "slavename": "talos-linux64-ix-003", 20:16:41 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:16:41 INFO - "platform": "ubuntu64_hw", 20:16:41 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:16:41 INFO - "branch": "fx-team", 20:16:41 INFO - "repo_path": "integration/fx-team", 20:16:41 INFO - "revision": "f59918cf04fa5954101b0274ebf60fb7e11e7a21", 20:16:41 INFO - "stage_platform": "linux64-pgo", 20:16:41 INFO - "builduid": "4fa243fee7c2480abdadba39e3dcf958", 20:16:41 INFO - "slavebuilddir": "test" 20:16:41 INFO - } 20:16:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/JDHg30GISdiIHZo-asFeYA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 20:16:41 INFO - Running post-action listener: _resource_record_post_action 20:16:41 INFO - ##### 20:16:41 INFO - ##### Finished read-buildbot-config step (success) 20:16:41 INFO - ##### 20:16:41 INFO - ##### 20:16:41 INFO - ##### Running download-and-extract step. 20:16:41 INFO - ##### 20:16:41 INFO - Running pre-action listener: _resource_record_pre_action 20:16:41 INFO - Running main action method: download_and_extract 20:16:41 INFO - mkdir: /builds/slave/test/build/tests 20:16:41 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')]} 20:16:41 INFO - https://queue.taskcluster.net/v1/task/JDHg30GISdiIHZo-asFeYA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:16:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDHg30GISdiIHZo-asFeYA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:16:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDHg30GISdiIHZo-asFeYA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:16:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDHg30GISdiIHZo-asFeYA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:16:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDHg30GISdiIHZo-asFeYA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:16:44 INFO - Downloaded 1361 bytes. 20:16:44 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:16:44 INFO - Using the following test package requirements: 20:16:44 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:16:44 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:16:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:16:44 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:16:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:16:44 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:16:44 INFO - u'jsshell-linux-x86_64.zip'], 20:16:44 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:16:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:16:44 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:16:44 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:16:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:16:44 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:16:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:16:44 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:16:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:16:44 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:16:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:16:44 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:16: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')]} 20:16:44 INFO - https://queue.taskcluster.net/v1/task/JDHg30GISdiIHZo-asFeYA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:16:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDHg30GISdiIHZo-asFeYA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:16:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDHg30GISdiIHZo-asFeYA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:16:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDHg30GISdiIHZo-asFeYA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:16:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDHg30GISdiIHZo-asFeYA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:16:46 INFO - Downloaded 24410635 bytes. 20:16:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:16:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:16:47 INFO - Return code: 0 20:16:47 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:16: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')]} 20:16:47 INFO - https://queue.taskcluster.net/v1/task/JDHg30GISdiIHZo-asFeYA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:16:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDHg30GISdiIHZo-asFeYA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:16:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDHg30GISdiIHZo-asFeYA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:16:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDHg30GISdiIHZo-asFeYA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:16:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDHg30GISdiIHZo-asFeYA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:16:51 INFO - Downloaded 24410635 bytes. 20:16:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:16:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:16:52 INFO - Return code: 0 20:16: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')]} 20:16:52 INFO - https://queue.taskcluster.net/v1/task/JDHg30GISdiIHZo-asFeYA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:16:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDHg30GISdiIHZo-asFeYA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:16:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDHg30GISdiIHZo-asFeYA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:16:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDHg30GISdiIHZo-asFeYA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:16:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDHg30GISdiIHZo-asFeYA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:16:53 INFO - Downloaded 10834034 bytes. 20:16:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:16:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 20:16:53 INFO - Return code: 0 20:16:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:16:53 INFO - https://queue.taskcluster.net/v1/task/JDHg30GISdiIHZo-asFeYA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:16:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDHg30GISdiIHZo-asFeYA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:16:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDHg30GISdiIHZo-asFeYA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:16:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDHg30GISdiIHZo-asFeYA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:16:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDHg30GISdiIHZo-asFeYA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:16:55 INFO - Downloaded 58741761 bytes. 20:16:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JDHg30GISdiIHZo-asFeYA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:16:55 INFO - mkdir: /builds/slave/test/properties 20:16:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:16:55 INFO - Writing to file /builds/slave/test/properties/build_url 20:16:55 INFO - Contents: 20:16:55 INFO - build_url:https://queue.taskcluster.net/v1/task/JDHg30GISdiIHZo-asFeYA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:16:56 INFO - Running post-action listener: _resource_record_post_action 20:16:56 INFO - Running post-action listener: set_extra_try_arguments 20:16:56 INFO - ##### 20:16:56 INFO - ##### Finished download-and-extract step (success) 20:16:56 INFO - ##### 20:16:56 INFO - ##### 20:16:56 INFO - ##### Running populate-webroot step. 20:16:56 INFO - ##### 20:16:56 INFO - Running pre-action listener: _resource_record_pre_action 20:16:56 INFO - Running main action method: populate_webroot 20:16:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:16:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:16:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:16:56 INFO - '--tppagecycles', 20:16:56 INFO - '7'], 20:16:56 INFO - 'tests': ['tsvgm']}}, 20:16:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:16:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:16:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:16:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:16:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:16:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:16:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:56 INFO - 'talos_options': ['--disable-e10s'], 20:16:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:16:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:16:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:56 INFO - 'talos_options': ['--disable-e10s'], 20:16:56 INFO - 'tests': ['damp', 'tps']}, 20:16:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:56 INFO - 'tests': ['damp', 'tps']}, 20:16:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:16:56 INFO - 'tests': ['dromaeo_dom']}, 20:16:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:16:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:16:56 INFO - 'tests': ['a11yr', 20:16:56 INFO - 'ts_paint', 20:16:56 INFO - 'tpaint', 20:16:56 INFO - 'sessionrestore', 20:16:56 INFO - 'sessionrestore_no_auto_restore', 20:16:56 INFO - 'tabpaint']}, 20:16:56 INFO - 'other-e10s': {'tests': ['a11yr', 20:16:56 INFO - 'ts_paint', 20:16:56 INFO - 'tpaint', 20:16:56 INFO - 'sessionrestore', 20:16:56 INFO - 'sessionrestore_no_auto_restore', 20:16:56 INFO - 'tabpaint']}, 20:16:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:16:56 INFO - 'ts_paint', 20:16:56 INFO - 'tpaint', 20:16:56 INFO - 'sessionrestore', 20:16:56 INFO - 'sessionrestore_no_auto_restore', 20:16:56 INFO - 'tabpaint']}, 20:16:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:16:56 INFO - 'ts_paint', 20:16:56 INFO - 'tpaint', 20:16:56 INFO - 'sessionrestore', 20:16:56 INFO - 'sessionrestore_no_auto_restore', 20:16:56 INFO - 'tabpaint']}, 20:16:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:16:56 INFO - 'tests': ['a11yr', 20:16:56 INFO - 'ts_paint', 20:16:56 INFO - 'tpaint', 20:16:56 INFO - 'sessionrestore', 20:16:56 INFO - 'sessionrestore_no_auto_restore', 20:16:56 INFO - 'tabpaint']}, 20:16:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:16:56 INFO - 'tests': ['a11yr', 20:16:56 INFO - 'ts_paint', 20:16:56 INFO - 'tpaint', 20:16:56 INFO - 'sessionrestore', 20:16:56 INFO - 'sessionrestore_no_auto_restore', 20:16:56 INFO - 'tabpaint']}, 20:16:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:16:56 INFO - 'tests': ['tsvgx', 20:16:56 INFO - 'tsvgr_opacity', 20:16:56 INFO - 'tart', 20:16:56 INFO - 'tscrollx', 20:16:56 INFO - 'cart']}, 20:16:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:16:56 INFO - 'tsvgr_opacity', 20:16:56 INFO - 'tart', 20:16:56 INFO - 'tscrollx', 20:16:56 INFO - 'cart']}, 20:16:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:56 INFO - 'talos_options': ['--disable-e10s'], 20:16:56 INFO - 'tests': ['tp5o']}, 20:16:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:56 INFO - 'tests': ['tp5o']}, 20:16:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:56 INFO - 'talos_options': ['--disable-e10s', 20:16:56 INFO - '--xperf_path', 20:16:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:16:56 INFO - 'tests': ['tp5n']}, 20:16:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:16:56 INFO - 'talos_options': ['--xperf_path', 20:16:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:16:56 INFO - 'tests': ['tp5n']}}, 20:16:56 INFO - 'talos.zip': {'path': '', 20:16:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:16:56 INFO - Running post-action listener: _resource_record_post_action 20:16:56 INFO - ##### 20:16:56 INFO - ##### Finished populate-webroot step (success) 20:16:56 INFO - ##### 20:16:56 INFO - ##### 20:16:56 INFO - ##### Running create-virtualenv step. 20:16:56 INFO - ##### 20:16:56 INFO - Running pre-action listener: _resource_record_pre_action 20:16:56 INFO - Running main action method: create_virtualenv 20:16:56 INFO - Creating virtualenv /builds/slave/test/build/venv 20:16:56 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 20:16:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:16:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:16:56 INFO - Using real prefix '/usr' 20:16:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:16:57 INFO - Installing distribute.............................................................................................................................................................................................done. 20:16:58 INFO - Installing pip.................done. 20:16:58 INFO - Return code: 0 20:16:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:16:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:16:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:16:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:59 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 0x7fd21337bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1370770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ff9c0>, '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 0x14008c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1400d50>, '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': '7de08804244eb36560b44971000001c3-1464576464.595091-1281982449', '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 20:16:59 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 20:16:59 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 20:16:59 INFO - Using env: {'DISPLAY': ':0', 20:16:59 INFO - 'HOME': '/home/cltbld', 20:16:59 INFO - 'LANG': 'en_US.UTF-8', 20:16:59 INFO - 'LANGUAGE': 'en_US:en', 20:16:59 INFO - 'LOGNAME': 'cltbld', 20:16:59 INFO - 'MAIL': '/var/mail/cltbld', 20:16:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:59 INFO - 'MOZ_NO_REMOTE': '1', 20:16:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:59 INFO - 'NO_EM_RESTART': '1', 20:16:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:59 INFO - 'PWD': '/builds/slave/test', 20:16:59 INFO - 'SHELL': '/bin/bash', 20:16:59 INFO - 'SHLVL': '1', 20:16:59 INFO - 'TERM': 'linux', 20:16:59 INFO - 'TMOUT': '86400', 20:16:59 INFO - 'USER': 'cltbld', 20:16:59 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464576464.595091-1281982449', 20:16:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:59 INFO - '_': '/tools/buildbot/bin/python'} 20:16:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:59 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 20:16:59 INFO - Cleaning up... 20:16:59 INFO - Return code: 0 20:16:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:16: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')]} 20:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16: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')]} 20:16:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd21337bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1370770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ff9c0>, '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 0x14008c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1400d50>, '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': '7de08804244eb36560b44971000001c3-1464576464.595091-1281982449', '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 20:16:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:16:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:16:59 INFO - Using env: {'DISPLAY': ':0', 20:16:59 INFO - 'HOME': '/home/cltbld', 20:16:59 INFO - 'LANG': 'en_US.UTF-8', 20:16:59 INFO - 'LANGUAGE': 'en_US:en', 20:16:59 INFO - 'LOGNAME': 'cltbld', 20:16:59 INFO - 'MAIL': '/var/mail/cltbld', 20:16:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:59 INFO - 'MOZ_NO_REMOTE': '1', 20:16:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:59 INFO - 'NO_EM_RESTART': '1', 20:16:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:59 INFO - 'PWD': '/builds/slave/test', 20:16:59 INFO - 'SHELL': '/bin/bash', 20:16:59 INFO - 'SHLVL': '1', 20:16:59 INFO - 'TERM': 'linux', 20:16:59 INFO - 'TMOUT': '86400', 20:16:59 INFO - 'USER': 'cltbld', 20:16:59 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464576464.595091-1281982449', 20:16:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:59 INFO - '_': '/tools/buildbot/bin/python'} 20:16:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:59 INFO - Downloading/unpacking psutil>=3.1.1 20:16:59 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 20:16:59 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 20:16:59 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 20:16:59 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 20:16:59 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 20:16:59 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 20:17:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:17:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:17:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:17:01 INFO - Installing collected packages: psutil 20:17:01 INFO - Running setup.py install for psutil 20:17:01 INFO - building 'psutil._psutil_linux' extension 20:17:01 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 20:17:01 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 20:17:01 INFO - building 'psutil._psutil_posix' extension 20:17:01 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 20:17:01 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 20:17:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:17:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:17:01 INFO - Successfully installed psutil 20:17:01 INFO - Cleaning up... 20:17:01 INFO - Return code: 0 20:17:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:17:01 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')]} 20:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:17:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:01 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')]} 20:17:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:17:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd21337bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1370770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ff9c0>, '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 0x14008c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1400d50>, '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': '7de08804244eb36560b44971000001c3-1464576464.595091-1281982449', '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 20:17:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:17:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:17:01 INFO - Using env: {'DISPLAY': ':0', 20:17:01 INFO - 'HOME': '/home/cltbld', 20:17:01 INFO - 'LANG': 'en_US.UTF-8', 20:17:01 INFO - 'LANGUAGE': 'en_US:en', 20:17:01 INFO - 'LOGNAME': 'cltbld', 20:17:01 INFO - 'MAIL': '/var/mail/cltbld', 20:17:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:01 INFO - 'MOZ_NO_REMOTE': '1', 20:17:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:17:01 INFO - 'NO_EM_RESTART': '1', 20:17:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:17:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:01 INFO - 'PWD': '/builds/slave/test', 20:17:01 INFO - 'SHELL': '/bin/bash', 20:17:01 INFO - 'SHLVL': '1', 20:17:01 INFO - 'TERM': 'linux', 20:17:01 INFO - 'TMOUT': '86400', 20:17:01 INFO - 'USER': 'cltbld', 20:17:01 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464576464.595091-1281982449', 20:17:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:01 INFO - '_': '/tools/buildbot/bin/python'} 20:17:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:17:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:17: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 20:17: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 20:17: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 20:17: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 20:17: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 20:17: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 20:17:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:17:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:17:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:17:04 INFO - Installing collected packages: mozsystemmonitor 20:17:04 INFO - Running setup.py install for mozsystemmonitor 20:17:04 INFO - Successfully installed mozsystemmonitor 20:17:04 INFO - Cleaning up... 20:17:04 INFO - Return code: 0 20:17:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:17:04 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')]} 20:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:17:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:04 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')]} 20:17:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:17:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:04 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 0x7fd21337bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1370770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ff9c0>, '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 0x14008c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1400d50>, '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': '7de08804244eb36560b44971000001c3-1464576464.595091-1281982449', '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 20:17:04 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 20:17:04 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 20:17:04 INFO - Using env: {'DISPLAY': ':0', 20:17:04 INFO - 'HOME': '/home/cltbld', 20:17:04 INFO - 'LANG': 'en_US.UTF-8', 20:17:04 INFO - 'LANGUAGE': 'en_US:en', 20:17:04 INFO - 'LOGNAME': 'cltbld', 20:17:04 INFO - 'MAIL': '/var/mail/cltbld', 20:17:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:04 INFO - 'MOZ_NO_REMOTE': '1', 20:17:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:17:04 INFO - 'NO_EM_RESTART': '1', 20:17:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:17:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:04 INFO - 'PWD': '/builds/slave/test', 20:17:04 INFO - 'SHELL': '/bin/bash', 20:17:04 INFO - 'SHLVL': '1', 20:17:04 INFO - 'TERM': 'linux', 20:17:04 INFO - 'TMOUT': '86400', 20:17:04 INFO - 'USER': 'cltbld', 20:17:04 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464576464.595091-1281982449', 20:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:04 INFO - '_': '/tools/buildbot/bin/python'} 20:17:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:17:04 INFO - Downloading/unpacking blobuploader==1.2.4 20:17: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 20:17: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 20:17: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 20:17: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 20:17: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 20:17: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 20:17:06 INFO - Downloading blobuploader-1.2.4.tar.gz 20:17:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:17:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:17:06 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 20:17:06 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 20:17:06 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 20:17:06 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 20:17:06 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 20:17:06 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 20:17:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:17:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:17:06 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 20:17:06 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 20:17:06 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 20:17:06 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 20:17:06 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 20:17:06 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 20:17:07 INFO - Downloading docopt-0.6.1.tar.gz 20:17:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:17:07 INFO - Installing collected packages: blobuploader, requests, docopt 20:17:07 INFO - Running setup.py install for blobuploader 20:17:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:17:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:17:07 INFO - Running setup.py install for requests 20:17:07 INFO - Running setup.py install for docopt 20:17:07 INFO - Successfully installed blobuploader requests docopt 20:17:07 INFO - Cleaning up... 20:17:07 INFO - Return code: 0 20:17:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:17:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:17:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:17:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:17:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:07 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 0x7fd21337bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1370770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ff9c0>, '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 0x14008c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1400d50>, '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': '7de08804244eb36560b44971000001c3-1464576464.595091-1281982449', '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 20:17:07 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 20:17:07 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 20:17:07 INFO - Using env: {'DISPLAY': ':0', 20:17:07 INFO - 'HOME': '/home/cltbld', 20:17:07 INFO - 'LANG': 'en_US.UTF-8', 20:17:07 INFO - 'LANGUAGE': 'en_US:en', 20:17:07 INFO - 'LOGNAME': 'cltbld', 20:17:07 INFO - 'MAIL': '/var/mail/cltbld', 20:17:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:07 INFO - 'MOZ_NO_REMOTE': '1', 20:17:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:17:07 INFO - 'NO_EM_RESTART': '1', 20:17:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:17:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:07 INFO - 'PWD': '/builds/slave/test', 20:17:07 INFO - 'SHELL': '/bin/bash', 20:17:07 INFO - 'SHLVL': '1', 20:17:07 INFO - 'TERM': 'linux', 20:17:07 INFO - 'TMOUT': '86400', 20:17:07 INFO - 'USER': 'cltbld', 20:17:07 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464576464.595091-1281982449', 20:17:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:07 INFO - '_': '/tools/buildbot/bin/python'} 20:17:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:17:07 INFO - Running setup.py (path:/tmp/pip-tstYtk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:17:08 INFO - Running setup.py (path:/tmp/pip-J6Nk2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:17:08 INFO - Running setup.py (path:/tmp/pip-8YABPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:17:08 INFO - Running setup.py (path:/tmp/pip-_8gg1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:17:08 INFO - Running setup.py (path:/tmp/pip-jDUugl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:17:08 INFO - Running setup.py (path:/tmp/pip-3QTvvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:17:08 INFO - Running setup.py (path:/tmp/pip-JfINji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:17:08 INFO - Running setup.py (path:/tmp/pip-iGbBlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:17:08 INFO - Running setup.py (path:/tmp/pip-H1FyZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:17:08 INFO - Running setup.py (path:/tmp/pip-hWkRnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:17:08 INFO - Running setup.py (path:/tmp/pip-SoLgI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:17:08 INFO - Running setup.py (path:/tmp/pip-Sb06dF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:17:08 INFO - Running setup.py (path:/tmp/pip-jiYgMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:17:08 INFO - Running setup.py (path:/tmp/pip-mksRmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:17:08 INFO - Running setup.py (path:/tmp/pip-i4aaw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:17:09 INFO - Running setup.py (path:/tmp/pip-1KPgo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:17:09 INFO - Running setup.py (path:/tmp/pip-q3M37Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:17:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:17:09 INFO - Running setup.py install for manifestparser 20:17:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:17:09 INFO - Running setup.py install for mozcrash 20:17:09 INFO - Running setup.py install for mozdebug 20:17:09 INFO - Running setup.py install for mozdevice 20:17:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:17:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:17:09 INFO - Running setup.py install for mozfile 20:17:09 INFO - Running setup.py install for mozhttpd 20:17:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:17:09 INFO - Running setup.py install for mozinfo 20:17:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:17:09 INFO - Running setup.py install for mozInstall 20:17:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:17:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:17:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:17:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:17:09 INFO - Running setup.py install for mozleak 20:17:10 INFO - Running setup.py install for mozlog 20:17:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:17:10 INFO - Running setup.py install for moznetwork 20:17:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:17:10 INFO - Running setup.py install for mozprocess 20:17:10 INFO - Running setup.py install for mozprofile 20:17:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:17:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:17:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:17:10 INFO - Running setup.py install for mozrunner 20:17:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:17:10 INFO - Running setup.py install for mozscreenshot 20:17:10 INFO - Running setup.py install for moztest 20:17:10 INFO - Running setup.py install for mozversion 20:17:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:17:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:17:10 INFO - Cleaning up... 20:17:10 INFO - Return code: 0 20:17:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:17:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:17:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:17:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:17:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:10 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 0x7fd21337bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1370770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ff9c0>, '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 0x14008c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1400d50>, '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': '7de08804244eb36560b44971000001c3-1464576464.595091-1281982449', '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 20:17:10 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 20:17:10 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 20:17:10 INFO - Using env: {'DISPLAY': ':0', 20:17:10 INFO - 'HOME': '/home/cltbld', 20:17:10 INFO - 'LANG': 'en_US.UTF-8', 20:17:10 INFO - 'LANGUAGE': 'en_US:en', 20:17:10 INFO - 'LOGNAME': 'cltbld', 20:17:10 INFO - 'MAIL': '/var/mail/cltbld', 20:17:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:10 INFO - 'MOZ_NO_REMOTE': '1', 20:17:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:17:10 INFO - 'NO_EM_RESTART': '1', 20:17:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:17:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:10 INFO - 'PWD': '/builds/slave/test', 20:17:10 INFO - 'SHELL': '/bin/bash', 20:17:10 INFO - 'SHLVL': '1', 20:17:10 INFO - 'TERM': 'linux', 20:17:10 INFO - 'TMOUT': '86400', 20:17:10 INFO - 'USER': 'cltbld', 20:17:10 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464576464.595091-1281982449', 20:17:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:10 INFO - '_': '/tools/buildbot/bin/python'} 20:17:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:17:11 INFO - Running setup.py (path:/tmp/pip-btpGtM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:17:11 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)) 20:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:17:11 INFO - Running setup.py (path:/tmp/pip-5pzq9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:17:11 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)) 20:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:17:11 INFO - Running setup.py (path:/tmp/pip-1FZCUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:17:11 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)) 20:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:17:11 INFO - Running setup.py (path:/tmp/pip-s1HdG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:17:11 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)) 20:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:17:11 INFO - Running setup.py (path:/tmp/pip-vzMYSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:17:11 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)) 20:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:17:11 INFO - Running setup.py (path:/tmp/pip-t_1RMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:17:11 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)) 20:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:17:11 INFO - Running setup.py (path:/tmp/pip-tKXTVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:17:11 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)) 20:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:17:11 INFO - Running setup.py (path:/tmp/pip-aXi9a2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:17:11 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)) 20:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:17:11 INFO - Running setup.py (path:/tmp/pip-JiLHSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:17:11 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)) 20:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:17:11 INFO - Running setup.py (path:/tmp/pip-wvts6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:17:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:17:11 INFO - Running setup.py (path:/tmp/pip-Kr8pBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:17:11 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)) 20:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:17:11 INFO - Running setup.py (path:/tmp/pip-DA7wVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:17:12 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)) 20:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:17:12 INFO - Running setup.py (path:/tmp/pip-3JOPfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:17:12 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)) 20:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:17:12 INFO - Running setup.py (path:/tmp/pip-qRUPkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:17:12 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)) 20:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:17:12 INFO - Running setup.py (path:/tmp/pip-Y55gma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:17:12 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)) 20:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:17:12 INFO - Running setup.py (path:/tmp/pip-SF4cQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:17:12 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)) 20:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:17:12 INFO - Running setup.py (path:/tmp/pip-tXgzDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:17:12 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)) 20:17:12 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)) 20:17:12 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)) 20:17:12 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)) 20:17:12 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)) 20:17:12 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)) 20:17:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:17:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:17:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:17:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:17:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:17:14 INFO - Downloading blessings-1.6.tar.gz 20:17:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:17:14 INFO - Installing collected packages: blessings 20:17:14 INFO - Running setup.py install for blessings 20:17:14 INFO - Successfully installed blessings 20:17:14 INFO - Cleaning up... 20:17:14 INFO - Return code: 0 20:17:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:17:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:17:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:17:14 INFO - Reading from file tmpfile_stdout 20:17:14 INFO - Current package versions: 20:17:14 INFO - argparse == 1.2.1 20:17:14 INFO - blessings == 1.6 20:17:14 INFO - blobuploader == 1.2.4 20:17:14 INFO - docopt == 0.6.1 20:17:14 INFO - manifestparser == 1.1 20:17:14 INFO - mozInstall == 1.12 20:17:14 INFO - mozcrash == 0.17 20:17:14 INFO - mozdebug == 0.1 20:17:14 INFO - mozdevice == 0.48 20:17:14 INFO - mozfile == 1.2 20:17:14 INFO - mozhttpd == 0.7 20:17:14 INFO - mozinfo == 0.9 20:17:14 INFO - mozleak == 0.1 20:17:14 INFO - mozlog == 3.2 20:17:14 INFO - moznetwork == 0.27 20:17:14 INFO - mozprocess == 0.22 20:17:14 INFO - mozprofile == 0.28 20:17:14 INFO - mozrunner == 6.11 20:17:14 INFO - mozscreenshot == 0.1 20:17:14 INFO - mozsystemmonitor == 0.3 20:17:14 INFO - moztest == 0.7 20:17:14 INFO - mozversion == 1.4 20:17:14 INFO - psutil == 3.1.1 20:17:14 INFO - requests == 1.2.3 20:17:14 INFO - wsgiref == 0.1.2 20:17:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:17:14 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')]} 20:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:17:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:14 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')]} 20:17:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:17:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:14 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 0x7fd21337bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1370770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ff9c0>, '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 0x14008c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1400d50>, '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': '7de08804244eb36560b44971000001c3-1464576464.595091-1281982449', '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 20:17:14 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 20:17:14 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 20:17:14 INFO - Using env: {'DISPLAY': ':0', 20:17:14 INFO - 'HOME': '/home/cltbld', 20:17:14 INFO - 'LANG': 'en_US.UTF-8', 20:17:14 INFO - 'LANGUAGE': 'en_US:en', 20:17:14 INFO - 'LOGNAME': 'cltbld', 20:17:14 INFO - 'MAIL': '/var/mail/cltbld', 20:17:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:14 INFO - 'MOZ_NO_REMOTE': '1', 20:17:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:17:14 INFO - 'NO_EM_RESTART': '1', 20:17:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:17:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:14 INFO - 'PWD': '/builds/slave/test', 20:17:14 INFO - 'SHELL': '/bin/bash', 20:17:14 INFO - 'SHLVL': '1', 20:17:14 INFO - 'TERM': 'linux', 20:17:14 INFO - 'TMOUT': '86400', 20:17:14 INFO - 'USER': 'cltbld', 20:17:14 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464576464.595091-1281982449', 20:17:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:14 INFO - '_': '/tools/buildbot/bin/python'} 20:17:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:17:14 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)) 20:17:14 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)) 20:17:14 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)) 20:17:14 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)) 20:17:14 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)) 20:17:14 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)) 20:17:14 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)) 20:17:14 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)) 20:17:14 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)) 20:17:14 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)) 20:17:14 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)) 20:17:14 INFO - Cleaning up... 20:17:14 INFO - Return code: 0 20:17:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:17:14 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')]} 20:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:17:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:14 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')]} 20:17:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:17:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:14 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 0x7fd21337bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1370770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ff9c0>, '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 0x14008c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1400d50>, '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': '7de08804244eb36560b44971000001c3-1464576464.595091-1281982449', '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 20:17:14 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 20:17:14 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 20:17:14 INFO - Using env: {'DISPLAY': ':0', 20:17:14 INFO - 'HOME': '/home/cltbld', 20:17:14 INFO - 'LANG': 'en_US.UTF-8', 20:17:14 INFO - 'LANGUAGE': 'en_US:en', 20:17:14 INFO - 'LOGNAME': 'cltbld', 20:17:14 INFO - 'MAIL': '/var/mail/cltbld', 20:17:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:14 INFO - 'MOZ_NO_REMOTE': '1', 20:17:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:17:14 INFO - 'NO_EM_RESTART': '1', 20:17:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:17:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:14 INFO - 'PWD': '/builds/slave/test', 20:17:14 INFO - 'SHELL': '/bin/bash', 20:17:14 INFO - 'SHLVL': '1', 20:17:14 INFO - 'TERM': 'linux', 20:17:14 INFO - 'TMOUT': '86400', 20:17:14 INFO - 'USER': 'cltbld', 20:17:14 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464576464.595091-1281982449', 20:17:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:14 INFO - '_': '/tools/buildbot/bin/python'} 20:17:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:17:15 INFO - Downloading/unpacking jsonschema 20:17:15 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 20:17:15 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 20:17:15 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 20:17:15 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 20:17:15 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 20:17:15 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 20:17:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:17:17 INFO - Downloading/unpacking functools32 (from jsonschema) 20:17:17 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 20:17:17 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 20:17:17 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 20:17:17 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 20:17:17 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 20:17:17 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 20:17:17 INFO - Downloading functools32-3.2.3-2.tar.gz 20:17:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:17:17 INFO - warning: no files found matching '*.txt' 20:17:17 INFO - no previously-included directories found matching 'build' 20:17:17 INFO - no previously-included directories found matching 'dist' 20:17:17 INFO - no previously-included directories found matching '.git*' 20:17:17 INFO - Installing collected packages: jsonschema, functools32 20:17:17 INFO - Running setup.py install for functools32 20:17:17 INFO - warning: no files found matching '*.txt' 20:17:17 INFO - no previously-included directories found matching 'build' 20:17:17 INFO - no previously-included directories found matching 'dist' 20:17:17 INFO - no previously-included directories found matching '.git*' 20:17:17 INFO - Successfully installed jsonschema functools32 20:17:17 INFO - Cleaning up... 20:17:17 INFO - Return code: 0 20:17:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:17: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')]} 20:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:17:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17: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')]} 20:17:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:17:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:17:17 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 0x7fd21337bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1370770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ff9c0>, '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 0x14008c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1400d50>, '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': '7de08804244eb36560b44971000001c3-1464576464.595091-1281982449', '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 20:17:17 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 20:17:17 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 20:17:17 INFO - Using env: {'DISPLAY': ':0', 20:17:17 INFO - 'HOME': '/home/cltbld', 20:17:17 INFO - 'LANG': 'en_US.UTF-8', 20:17:17 INFO - 'LANGUAGE': 'en_US:en', 20:17:17 INFO - 'LOGNAME': 'cltbld', 20:17:17 INFO - 'MAIL': '/var/mail/cltbld', 20:17:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:17 INFO - 'MOZ_NO_REMOTE': '1', 20:17:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:17:17 INFO - 'NO_EM_RESTART': '1', 20:17:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:17:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:17 INFO - 'PWD': '/builds/slave/test', 20:17:17 INFO - 'SHELL': '/bin/bash', 20:17:17 INFO - 'SHLVL': '1', 20:17:17 INFO - 'TERM': 'linux', 20:17:17 INFO - 'TMOUT': '86400', 20:17:17 INFO - 'USER': 'cltbld', 20:17:17 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464576464.595091-1281982449', 20:17:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:17 INFO - '_': '/tools/buildbot/bin/python'} 20:17:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:17:17 INFO - Downloading/unpacking flake8 20:17:17 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 20:17:17 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 20:17:17 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 20:17:17 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 20:17:17 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 20:17:17 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 20:17:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:17:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:17:19 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 20:17:19 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 20:17:19 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 20:17:19 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 20:17:19 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 20:17:19 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 20:17:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:17:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:17:19 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 20:17:19 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 20:17:19 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 20:17:19 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 20:17:19 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 20:17:19 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 20:17:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:17:20 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 20:17:20 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 20:17:20 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 20:17:20 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 20:17:20 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 20:17:20 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 20:17:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:17:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:17:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:17:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:17:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:17:20 INFO - no previously-included directories found matching 'docs/_build' 20:17:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:17:20 INFO - Running setup.py install for pep8 20:17:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:17:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:17:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:17:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:17:20 INFO - no previously-included directories found matching 'docs/_build' 20:17:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:17:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:17:20 INFO - Cleaning up... 20:17:20 INFO - Return code: 0 20:17:20 INFO - Running post-action listener: _resource_record_post_action 20:17:20 INFO - Running post-action listener: _start_resource_monitoring 20:17:20 INFO - Starting resource monitoring. 20:17:20 INFO - ##### 20:17:20 INFO - ##### Finished create-virtualenv step (success) 20:17:20 INFO - ##### 20:17:20 INFO - ##### 20:17:20 INFO - ##### Running install step. 20:17:20 INFO - ##### 20:17:20 INFO - Running pre-action listener: _resource_record_pre_action 20:17:20 INFO - Running main action method: install 20:17:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:17:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:17:20 INFO - Reading from file tmpfile_stdout 20:17:20 INFO - Detecting whether we're running mozinstall >=1.0... 20:17:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:17:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:17:20 INFO - Reading from file tmpfile_stdout 20:17:20 INFO - Output received: 20:17:20 INFO - Usage: mozinstall [options] installer 20:17:20 INFO - Options: 20:17:20 INFO - -h, --help show this help message and exit 20:17:20 INFO - -d DEST, --destination=DEST 20:17:20 INFO - Directory to install application into. [default: 20:17:20 INFO - "/builds/slave/test"] 20:17:20 INFO - --app=APP Application being installed. [default: firefox] 20:17:20 INFO - mkdir: /builds/slave/test/build/application 20:17:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:17:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:17:37 INFO - Reading from file tmpfile_stdout 20:17:37 INFO - Output received: 20:17:37 INFO - /builds/slave/test/build/application/firefox/firefox 20:17:37 INFO - Running post-action listener: _resource_record_post_action 20:17:37 INFO - ##### 20:17:37 INFO - ##### Finished install step (success) 20:17:37 INFO - ##### 20:17:37 INFO - ##### 20:17:37 INFO - ##### Running run-tests step. 20:17:37 INFO - ##### 20:17:37 INFO - Running pre-action listener: _resource_record_pre_action 20:17:37 INFO - Running main action method: run_tests 20:17:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:17:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:17:37 INFO - Python 2.7.3 20:17:37 INFO - Return code: 0 20:17:37 INFO - grabbing minidump binary from tooltool 20:17:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:17:37 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ff9c0>, '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 0x14008c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1400d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:17:37 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 20:17:37 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 20:17:37 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 20:17:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:17:37 INFO - Return code: 0 20:17:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:17:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:17:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:17:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:17:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:17:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:17:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:17:38 INFO - Return code: 0 20:17:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JDHg30GISdiIHZo-asFeYA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 20:17:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JDHg30GISdiIHZo-asFeYA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 20:17:38 INFO - Using env: {'DISPLAY': ':0', 20:17:38 INFO - 'HOME': '/home/cltbld', 20:17:38 INFO - 'LANG': 'en_US.UTF-8', 20:17:38 INFO - 'LANGUAGE': 'en_US:en', 20:17:38 INFO - 'LOGNAME': 'cltbld', 20:17:38 INFO - 'MAIL': '/var/mail/cltbld', 20:17:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:17:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:17:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:17:38 INFO - 'MOZ_NO_REMOTE': '1', 20:17:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:17:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:17:38 INFO - 'NO_EM_RESTART': '1', 20:17:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:17:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:17:38 INFO - 'PWD': '/builds/slave/test', 20:17:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:17:38 INFO - 'SHELL': '/bin/bash', 20:17:38 INFO - 'SHLVL': '1', 20:17:38 INFO - 'TERM': 'linux', 20:17:38 INFO - 'TMOUT': '86400', 20:17:38 INFO - 'USER': 'cltbld', 20:17:38 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464576464.595091-1281982449', 20:17:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:17:38 INFO - '_': '/tools/buildbot/bin/python'} 20:17:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JDHg30GISdiIHZo-asFeYA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 20:17:38 INFO - mozversion application_buildid: 20160529173010 20:17:38 INFO - mozversion application_changeset: f59918cf04fa5954101b0274ebf60fb7e11e7a21 20:17:38 INFO - mozversion application_display_name: Nightly 20:17:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:17:38 INFO - mozversion application_name: Firefox 20:17:38 INFO - mozversion application_remotingname: firefox 20:17:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:17:38 INFO - mozversion application_vendor: Mozilla 20:17:38 INFO - mozversion application_version: 49.0a1 20:17:38 INFO - mozversion platform_buildid: 20160529173010 20:17:38 INFO - mozversion platform_changeset: f59918cf04fa5954101b0274ebf60fb7e11e7a21 20:17:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:17:38 INFO - mozversion platform_version: 49.0a1 20:17:38 INFO - using testdate: 1464578258 20:17:38 INFO - actual date: 1464578258 20:17:38 INFO - starting webserver on 'localhost:35675' 20:17:38 INFO - SUITE-START | Running 2 tests 20:17:38 INFO - TEST-START | dromaeo_css 20:17:38 INFO - operating with platform_type : linux_ 20:17:38 INFO - Initialising browser for dromaeo_css test... 20:17:38 INFO - TEST-INFO | started process 18130 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmLrfNL/profile http://localhost:35675/getInfo.html) 20:17:42 INFO - PROCESS | 18130 | 20:17:42 INFO - PROCESS | 18130 | (process:18197): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:17:43 INFO - PROCESS | 18130 | __metrics Screen width/height:1600/1200 20:17:43 INFO - PROCESS | 18130 | colorDepth:24 20:17:43 INFO - PROCESS | 18130 | Browser inner width/height: 1024/697 20:17:43 INFO - PROCESS | 18130 | __metrics 20:17:44 ERROR - PROCESS | 18130 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 20:17:45 INFO - TEST-INFO | 18130: exit 0 20:17:45 INFO - Browser initialized. 20:17:45 INFO - Running cycle 1/1 for dromaeo_css test... 20:17:45 INFO - TEST-INFO | started process 18248 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmLrfNL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:17:46 INFO - PROCESS | 18248 | 20:17:46 INFO - PROCESS | 18248 | (process:18309): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:17:57 INFO - PROCESS | 18248 | RSS: Main: 166338560 20:17:57 INFO - PROCESS | 18248 | 20:18:46 INFO - PROCESS | 18248 | 1464578326598 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] 20:20:54 INFO - PROCESS | 18248 | Cycle 1(1): loaded http://localhost:35675/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35675/tests/dromaeo/cssquery-ext.html) 20:20:55 INFO - PROCESS | 18248 | RSS: Main: 169951232 20:20:55 INFO - PROCESS | 18248 | 20:23:57 INFO - PROCESS | 18248 | Cycle 1(1): loaded http://localhost:35675/tests/dromaeo/cssquery-ext.html (next: http://localhost:35675/tests/dromaeo/cssquery-jquery.html) 20:23:57 INFO - PROCESS | 18248 | RSS: Main: 170127360 20:23:57 INFO - PROCESS | 18248 | 20:26:59 INFO - PROCESS | 18248 | Cycle 1(1): loaded http://localhost:35675/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35675/tests/dromaeo/cssquery-mootools.html) 20:27:00 INFO - PROCESS | 18248 | RSS: Main: 170823680 20:27:00 INFO - PROCESS | 18248 | 20:30:02 INFO - PROCESS | 18248 | Cycle 1(1): loaded http://localhost:35675/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35675/tests/dromaeo/cssquery-prototype.html) 20:30:02 INFO - PROCESS | 18248 | RSS: Main: 168210432 20:30:02 INFO - PROCESS | 18248 | 20:33:05 INFO - PROCESS | 18248 | Cycle 1(1): loaded http://localhost:35675/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35675/tests/dromaeo/cssquery-yui.html) 20:33:06 INFO - PROCESS | 18248 | RSS: Main: 170364928 20:33:06 INFO - PROCESS | 18248 | 20:36:08 INFO - PROCESS | 18248 | Cycle 1(1): loaded http://localhost:35675/tests/dromaeo/cssquery-yui.html (next: http://localhost:35675/tests/dromaeo/cssquery-dojo.html) 20:36:08 INFO - PROCESS | 18248 | RSS: Main: 171565056 20:36:08 INFO - PROCESS | 18248 | 20:36:08 INFO - PROCESS | 18248 | __start_tp_report 20:36:08 INFO - PROCESS | 18248 | _x_x_mozilla_page_load 20:36:08 INFO - PROCESS | 18248 | _x_x_mozilla_page_load_details 20:36:08 INFO - PROCESS | 18248 | |i|pagename|runs| 20:36:08 INFO - PROCESS | 18248 | |0;dojo.html;3124.156477751007;3148.9685103148963;3174.492081266998;3178.5867837181163;3186.64946855846;5349.384820745616;5393.4067252602235;5436.592255580832;5450.91823622646;5568.081266591008;5296.417394086648;5364.839054828361;5419.458054194579;5437.184422336642;5439.5376393006545;4921.876953076184;4945.455999840015;4981.651284410093;5098.872528186788;5137.3064636274;4914.213725803872;5116.155834287338;5139.563137133348;5141.126008578532;5144.768485418165;4902.632302577304;4928;4964.478729733362;4987.102321582114;5011.699298042129;4965.702057876503;4966.404031516205;4969.428515720702;4971.577415919651;5037.823676171316;4939.481354457802;4953.925691114636;4957.752112394366;4958.355413796219;4993.550580447777;5143.871403214949;5284.4187139414635;5324.5740340772645;5365.758540865631;5386.2997810284805;5828.679422631753;5847.26909136358;5849.502792262663;5851.268591426072;5879.176915231871;5672.602917795756;5874.060150375962;5877.882442351171;5881;5898.8820223595285;5297.12597421425;5331.680099194022;5345.465453454663;5346.385165705955;5351.1973204019705;5813.593048486566;5877.500412464903;5884.558658100659;5892.204552385459;5911.054231322968;5578.191162281528;5615.803446879339;5633.521150702236;5651.491365777099;5681.659100453986;5765.423457654285;5789.768409263666;5796.681182535001;5817.447342502455;5875.529957603381;5576.86057848557;5709.9714501427225;5824;5826.563007774434;5835.79574714883;5739.540836733051;5748.626339287933;5770.450538638592;5776.191333213354;5823.854403639943;4371.737695738266;4406.867793966187;4406.933895991563;4412.183746006999;4434.246178149722;3900.8829735107993;3915.5888631693833;3935.193285376491;3946.980265098656;3972.7417717848825;5497.120460726264;5568.081266590967;5574.637648552831;5576.553875689935;5629.605927585111;5835.124731290341;5880.147378630075;5881.176635271066;5890.175375447441;5892.351841297454;5389.973050134724;5554.250176226238;5570.192322113271;5605.0751625982075;5628;5059.316992206079;5064.11378008847;5071.746412679425;5098.617603679739;5102.846914592568;6147.907781383283;6154.969225153845;6159.384061593894;6160.599561028519;6163.753449862045;5662.7734890603915;5814.3604203538425;5822.301323840997;5884.146798714248;5899.528037756883;6032.336442991355;6043.36544662804;6066.332703402711;6082.36135205797;6086.513078953762;5540.861478463071;5746.252987111816;5748.655080695172;5752.13717942312;5768.451997060272;5758.971205143947;5771.105478650816;5774.0761478163295;5794.594378393472;5798.536117110537;5599.132134519156;5705.62913410627;5708.315002199763;5712.371639119777;5729.455701708331;5448.128299472065;5665.5750818689585;5673.74468148926;5684.346300175533;5692.943070569241;5453.345598528202;5513.007658621486;5557.527610153183;5626.409227031103;5757.827265182052;5682.77268909239;5686.4029276926985;5693.943060569507;5694.544436445157;5727.255456790591;5380.381256155436;5509.752061157177;5578.86052848682;5586.273784408164;5609.691466969356 20:36:08 INFO - PROCESS | 18248 | |1;ext.html;589.5607772209702;626.8902941985157;647.5596594315865;650.8047585724285;667.0494545272987;42690.78654606726;43929;43995;44238.33642495361;47514;45144.322835157414;45186.54813451864;45439.77280113595;45605;45764.77117614407;8671.826563468727;8894.199522043014;8912.197902188802;8922.464652120894;8924.55377231139;8837.867431988525;8910.599023043946;8924.152205540464;8925.55372231389;8933.017368089504;8837.646494140226;8846.911530884674;8863.867041994376;8905.510196939165;8974.685885993991;8753.868691969625;8832.514211718353;8874.955625221897;8881.777955551099;8891.777705557348;8705.825883482295;8833.072527384596;8843.557822108869;8854.601542930519;8866.069062748384;42411.57588424107;42901.141977160594;42908.78545607283;42929.14141717148;42965.35551966692;3382.2897191589796;3629.219717760694;3718.1448266898497;3934.15415685629;3945.960540394588;33210.169745756546;33276;33318.333633327195;33362.1659458513;35066.6493335066;4448.799804008795;4476.6418686505;4477.126960242721;4501.369808226851;4571.817127314904;365225;366829;368023;369094.9999999973;369190;59812.401875980686;60272.39727602756;60349.69825150846;60489.395106048374;60529;36263.81868090643;37137.257254854754;37299.25401491955;39216;39218.60781392206;15143.469978550918;15167.848321516864;15225.695486090437;15283.312250948735;15284.235788210544;11396.373199473943;11396.715082122848;11403.42982850854;11416.942915285537;11484.483198256099;20030.49923751918;20076.59846803056;20196.798032019786;20288.492787680425;20303.59392812165;7188.892166617505;7292.34368906801;7358.11702595692;7362.926370736332;7473.701051957861;995.4425521707722;1112.0825319111766;1115.4701516779628;1152.9538818447168;1159.5187996981326;31412.842935785175;32445.675543244266;32472.51291230586;32502.512462313083;33147.50278745821;1102.0357187460972;1154.468944285638;1166.3759888459804;1188.1504724122121;1203.0916657923212;16727.665446690997;17291;17305.480835574952;17324.566885827957;17500;521031;521666;522793;523900;524123;41004.1799164021;41205.38191927123;41311.586884130775;41608.791956040026;41611.791941040705;1334.652990222549;1388.632012516704;1396.958091257264;1399.5031763723732;1409.5700811252461;30514;31809.681903181598;32050.19874503156;32338.676613234507;32598.34803303968;52603.73698131485;52900;52954;53043.20435193398;53086;421059;427605;428513;432093;433334;29089;29123.271918202216;29270.7072929268;29406.705932940396;29412;49591.13165809104;49902;50359.24461133013;50501.49498504968;50613.493865060875;41238.58761412348;42301.576984231;42632.57367426286;42722.78638606787;43534.34698479462;41742.58257417508;41878.58121418747;42482.15035699207;42856.5714342865;43102.78448607737;35202.647973520965;40076;40337.59662403339;41493.585064148974;42789.57210427856;36890;37535;37901.75563745862;38155.23689526138;38350;28415.573766393107;28674;28719.569206461503;29088.563671545366;29249.561256581594 20:36:08 INFO - PROCESS | 18248 | |2;jquery.html;396.18979187561416;396.734188093977;399.301222859995;403.10108458138353;419.287211740042;17632.38286659967;18802.15390307436;19005.904970475127;19317.903410482926;19327.226910923564;18250.817491825077;18291.268349266014;18523.351682691107;18951.905240473814;18967.430977070675;5534.280543529356;5573.052581061219;5742.138679198112;5755.280589926259;5756.366799652035;5652.689102099383;5658.830235092933;5676.148577713335;5676.403977582357;5701.059325211335;5435.619506634537;5569.331680198382;5681.062624666925;5714.342850572196;5715.057015592422;5658.943410565904;5679.772809087632;5681.261436013312;5684.516816070639;5685.346185188715;4910.975445122787;5050;5057.140286151363;5061.342025536694;5065.037642847848;21492.355229343146;21804.45488862775;22129.889350553305;22327.553448930932;22335.888320558457;2050.6103840270302;2390.4740956989435;2623.632691423183;2894.3921776426973;2915.3731947631363;9476.763080922963;9995.70012899614;10036.24728145392;10270.845937310947;10604.310719803188;1948.7076938459202;1960.823525882663;2001.1195074167465;2010.8994550272573;2021.20162535799;70261;74216.25783742148;74580.25419745788;79057.60471197664;79247;10304.690859274233;10776.137908967265;10896.564137434414;11009;11054.949779770908;14951.626209344853;14962.70074598502;14981.625459363604;15074.924625376803;15092.094474331576;7521.548707077593;7713.460057796013;7776.339011184;7863;7869.803254918558;7291.197968223491;7479.252074792586;7514.47398682087;7572;7750.224977502317;4668.089722504079;4676.672632915664;4711.882202944886;4712.9057418851435;4746.1931471649905;1965.4202010406964;1973.822355987968;1977.555050113713;1999.7100420438956;2007.628588711093;955.6989548292265;970.8834939807127;995.0348162282575;1032.1742605915238;1053.773438710681;18005.909970450062;18338;18702;18763.437096887115;18796.154173062245;1017.5980487707315;1036.7356324137447;1042.7080417483116;1053.562771449855;1072.152999130678;10313.432761198055;10682;10735.248532602798;10742.409167495864;10796.298240614335;408248;408846;410917;443957;445245;56874.7156264216;58622;60198;76048;94844;1005.8088963096989;1059.3537941855461;1066.4561073852235;1072.7210925159516;1079.2067830144838;16904.915475422546;16994.915025424794;17136.742948856026;17267.654646907242;17394.304227830744;41222.58777412187;42524.149517010104;42930.14139717125;43021.35467968046;43101.3534796972;59259.703701481216;60065.69967150136;60810;61224.693876530335;61701.074483883676;8350.498970061573;8521;8577.614007369559;8670.176333248332;8758.868616970878;9509.904900950902;13165.012624053426;13212.339383031001;13335.866641333463;13385.748109371847;11082.224244303145;11456.885431145582;11496.540138394705;11595.304281743123;11777.941110294394;11234.213605047567;11426.428678565871;11617.941910290394;11638.767224655629;11804.822927656263;11212.159088068265;11342.886571134182;11499;11867.58463453775;11920.165588408729;7211.134663840373;7544.132424771222;7594.126675432175;7858.646360913658;8760.824783504422;11336.263142895685;11391.202615816814;11401.771964560829;11440.370779607201;11660.06719462458 20:36:08 INFO - PROCESS | 18248 | |3;mootools.html;1479.3934486860387;1509.37360995187;1662.2686018152012;1809.2582041363044;1821.3898344054749;7875.606219689022;8451.19713627206;8540.231379175873;9159.954200229005;9168.266538676899;8622.741317760478;8816.823663526742;8856.335774816898;8884.689035883745;8906.599203035863;2320.257517594366;2350.459394339303;2356.4108972756812;2369.490559529701;2378.21518898763;2264.2527965771255;2286.9885650571723;2319.8724070176136;2324.9651255231183;2340.8244381671443;2284.1434462076722;2294.6328587426015;2308.8960996755104;2329.5224478981854;2334.3347146063375;2234.3297010896827;2237.7202849643795;2247.3033359658557;2249.516353983893;2253.9549209015727;2230.464688474771;2231.4198308439923;2241.9775802241934;2244.8316376271846;2249.392663980716;8840;8874.423162494417;8902.73291801247;8922.732318030405;8931.776705582348;5108.897822043576;5237.266782650432;5240.947590524084;5264.184051472028;5271.446498117719;3416.572928383952;3581.7492775505725;3591.048372181374;3644.9817750911075;3668.743187976816;1141.201159188563;1156.5084838943499;1199.286424577375;1210.6307576189347;1214.5506162719762;12539.686507837287;12553.623391298275;12581.433835477426;12618.053645976497;12621.747565048647;4761.35721677576;4772.72167335975;4796.688215265996;4802.471728109905;4876.195427754381;10363.689089327332;10424.635137770294;10476.0571548561;10507.894921050845;10538.262321637565;5365.9731701342025;5413.998410294108;5429.457054294539;5444.700541470257;5457.154141108134;4378.16814805186;4672.789724462339;4790.161721698759;4823.734694591761;4912.38595175603;3929.351656976567;3966.6628336591134;3981.41208214657;4030.7581545107387;4105.322621767375;1224.2593231095236;1232.4946771823688;1239.5475651387178;1247.5758242197696;1259.5528587351541;942.2179590939504;997.2670087485692;1025.8461230815437;1036.2953191829477;1043.446973104256;5805.912911306334;5917.52659787216;6193.071039344134;6228.22147231596;6231.192770065608;445.5544455544456;456.9383133276965;464.3336811675257;464.91399091168245;471.93578480526196;4127.607877251657;4145.440365550672;4158.625723684822;4173.624373806372;4191.91616167675;10708;11152.052075573505;11233.269837460539;11237.83143252852;11289.209755317213;10879.782404351869;10982.615608453665;10984.725381865517;10989.670309890716;10997.12023038155;7943.801404965037;8363.20549547792;8436.53599052058;8436.957815210884;8439.409241353047;5955.285365756137;6027.276726792813;6082.665453400105;6192.721327540362;6213.254409470712;9941.950290248502;10191.184705223712;10248.948755256177;10302.587896484356;10303.278770485995;9550.808983820423;9881.357711748713;9955.352902061342;10231.59073637076;10273.075423211947;7661.272179142972;8243.299319557906;8430.957845210734;8525.062243153125;8593.31253499706;8396.370272229486;8404;8442.240198382175;8470.66117355299;8498.787530311793;7550.35821955118;7712.383009359126;7719.6140192989005;7813.960930195312;8049;7689.3848492121615;7771.766846994599;7796.337311328373;7800.609969501389;7908.5650289234645;7104.3961263293195;7132.465065120033;7185.784426467214;7195.46034047459;7202.099737532809;5259.500347466985;5367.651102678314;5422.972885135549;5463.371712253142;5467.17992301158;5158.148905430562;5243.973780131075;5478.753456094406;5523.309586301712;5640.182173584889 20:36:08 INFO - PROCESS | 18248 | |4;prototype.html;337.60837428582846;338.53282470191147;343.128453727532;344.3612099555325;345.9498372735955;5467.289252397193;5550.306211723535;5586.608937374385;5626.324841019074;5639.577031722627;5462.344518657756;5532.170174473831;5541.251930989315;5569.415211402805;5570.777168913249;4107.301758701021;4152.314868046768;4316.45329255739;4318.5465526119615;4341.544137865526;4300.419443375135;4310.094880075188;4315.287977483711;4341.3705012773125;4371.562843715619;4275.722078064916;4297;4299.183155200518;4329.112531930962;4354.608085272325;4045.3325201341595;4244.702870799046;4274.5939135782055;4289.1421715657;4290.4636920384955;3717.200801827593;3744.315058223783;3754.7796965986163;3757.7933213673236;3761.793101379423;5383.623146379755;5388.218708287276;5413.512783849473;5423.728813559345;5432.70120143392;4682.344471773954;4833.202521583935;4864.635152363587;4900.950990490085;4934.309196712463;5700.401457846908;5706.629069110536;5783.161441590988;5788.18965344852;5790.739416726257;3956.920861582781;4000.179963107556;4034.9394759078637;4037.0916543777707;4075.7554546726997;5862.296524417055;6062.63624182546;6066.817995460143;6074.605150665237;6118.4799292060225;4182.853600123981;4191.8742437726305;4206.978965105216;4212.4523811904255;4247.787610619456;4245.172191422705;4260.998665313648;4263.936040959388;4286.807093680792;4296.677749168824;4690.686607749835;4858.319835223072;4875.24433712775;4896.608271338285;4912.189488734319;5799.2750906136735;5817.88364232713;5820.447057529528;5826.970865145732;5849.385814489502;1463.5828788795143;1465.5090544667655;1478.2460944918168;1498.9625259368386;1501.7146742118962;895.1540793949655;937.231470194434;938.3103418987039;967.5307475874196;989.1048601016092;5502.449755024466;5528.585356098309;5545.916811247835;5582.33012038558;5599.356074051455;5862.882742345129;5914.645121292736;5949.25634295713;5968.403159683997;5986.551008674367;5374.247605335257;5578.693171875505;5584.441555844464;5589.692566908859;5634.661920284796;3121.2821051157907;3134.467140586106;3171.809691418476;3178.98410507946;3186.203449137716;5913.2608423947;6074.149619053248;6127.356627554132;6172.783952561728;6177.938220617736;5968.343482216953;5993.550483713739;6060.606060606135;6063.818085457443;6075.969620151871;6054.485368743706;6075.210222671113;6113.449789518964;6165.969170154211;6202.658853763086;5702.611211357443;5920.822375328747;5922.5261979040715;5956.851078723066;5959.821205363846;5797.884042319214;5837.854053648693;5849.356570777126;5859.824205273849;5872.911906321323;6015.879682406415;6141.570090093651;6149.2313460817395;6204.286507051746;6218.19163508741;4166.708330416963;4184.91630167401;4203.810828512663;4209.779164042393;4217.768022758778;5965.73154208053;6008.956954635445;6023.247094113236;6039.305479869871;6051.485623722033;5579.888402231852;5721.485066344049;5763.279590051244;5786.9131963019745;5841.714822738991;5573.972130139324;5726.370099289158;5739.684317362585;5771.769129234784;5777.884442311214;5504.834854954358;5646.520045796154;5659.490645841894;5700.429957004267;5778.8844223114465;5909.85225369352;5933.584649074523;5935.614185077956;5967.224260846062;5987.7604895805425;5636.1827535008015;5844.561657875762;5844.824655260349;5850.853728656818;5888.558358123072 20:36:08 INFO - PROCESS | 18248 | |5;yui.html;749.7825630567135;757.212499001039;806.7337778533084;859.4456575508797;865.6277800545763;13863.792043119362;14721.411143554245;14853.702925941489;16001;16100.114493702842;13680.110792798461;13693.93153034236;13708.177509349422;13735.313234338293;13737.24445155516;692.4495026453956;814.0922870998838;825.1583384947351;829.2453866981049;829.6225217526011;813.1827513349076;835.6657337065162;835.8495470815251;836.9790755231107;837.2339309531772;873.3362644390246;879.9208071273584;880.3485420788635;881.4579033894173;881.6209030117047;860.8708693695995;863.0290922711918;867.3061550759368;870.4820631724145;873.4322690251356;629.4366541944934;631.0565704272096;632.8006677896448;634.2484156274829;635.2028204603193;14795.926020369938;14840.628984275372;14843.332050057665;14879.776803347959;14890.032147910351;14125.646858828508;14322;14394.856051439561;14532.56402307922;14822.332995015251;11579.53681852725;11717.53129874804;11789.882101178964;11815.113866459964;12278.938605306916;3853.094522787143;3853.152306492595;3987.4218238355274;4024.5975402459812;4067.4508941292843;57208;57666.71166644182;57774.422255777325;57821.42178578245;57879.71060144672;11155.665330040112;11321.60374386909;11338.829917551244;11364.54541818318;11370.886291137149;20453.07961141752;20464.181432742524;20510.487237819172;20513;20514.28200013022;8009.639566219534;8333.2916702081;8342.749717508485;8480.787980300542;8761.649534018696;4828.66199366041;4829.084097996472;4885;4929.507049295114;4961.975190124026;3377.7973321600784;3473.756837021435;3508.9824550877083;3519.436890097572;3522;672.2000819025344;679.7994591595392;680.8978653202059;690.6408667492976;692.2869444472202;609.3236507476697;623.6133597169693;641.4131070070833;745.3105877063695;769.6305773228881;8736.8689469658;8817.250533704708;8860.335474839283;8987.730368088967;9104.8634270486;688.9931100689029;718.3032458515232;720.4632548751214;720.4884531982351;740.2893222506347;4098.323776576832;4398.8020539075815;4451.666125040635;4487.842925497592;4535.183666939916;67632;67687;68165.31834681689;68684.6565767178;68767;59309.70345148247;59732;59890.70054649699;62535.37464625295;63265.05102423467;55877.44122558804;56468.43531564632;57031.42968570344;57464;57621;8585.399022068395;8654.307655387427;8782.736517904474;8794;8964.865527017231;36694.44958325574;36785.81607092055;36822.63177368192;37058.444123337635;37340.813295933345;49207;49544.75227623839;50089.24866127084;50123;50196.24705629492;10674.46627668629;10781.46036271478;10831.51258193399;11133.387663678575;11434.885651143382;11882.22765520273;11892.048636109264;11940.70148246266;12057.189509946378;12367.567135150226;11135.777284454427;11219.71950701239;11437.942810285895;11609.767804644029;11742.412879356169;10877.619283325046;11109.722256943642;11249.49377278008;11341.319520828776;11682.182247242952;12986.870131298567;13220.405081771536;13265.137766045176;13553.25457099869;13780;10974.176936729937;11120.555177792798;11229.21395502307;11259.437028148724;11612.01297889655;11255.324680519196;11385.715357115807;11467.942660286646;11583;11715.941420292844 20:36:08 INFO - PROCESS | 18248 | __end_tp_report 20:36:08 INFO - PROCESS | 18248 | __start_cc_report 20:36:08 INFO - PROCESS | 18248 | _x_x_mozilla_cycle_collect,352 20:36:08 INFO - PROCESS | 18248 | __end_cc_report 20:36:08 INFO - PROCESS | 18248 | __startTimestamp1464579368884__endTimestamp 20:36:08 INFO - PROCESS | 18248 | 20:36:08 INFO - PROCESS | 18248 | ------- Summary: start ------- 20:36:08 INFO - PROCESS | 18248 | Number of tests: 6 20:36:08 INFO - PROCESS | 18248 | 20:36:08 INFO - PROCESS | 18248 | [#0] dojo.html Cycles:165 Average:5401.55 Median:5586.27 stddev:611.54 (10.9%) stddev-sans-first:586.74 20:36:08 INFO - PROCESS | 18248 | Values: 3124.2 3149.0 3174.5 3178.6 3186.6 5349.4 5393.4 5436.6 5450.9 5568.1 5296.4 5364.8 5419.5 5437.2 5439.5 4921.9 4945.5 4981.7 5098.9 5137.3 4914.2 5116.2 5139.6 5141.1 5144.8 4902.6 4928.0 4964.5 4987.1 5011.7 4965.7 4966.4 4969.4 4971.6 5037.8 4939.5 4953.9 4957.8 4958.4 4993.6 5143.9 5284.4 5324.6 5365.8 5386.3 5828.7 5847.3 5849.5 5851.3 5879.2 5672.6 5874.1 5877.9 5881.0 5898.9 5297.1 5331.7 5345.5 5346.4 5351.2 5813.6 5877.5 5884.6 5892.2 5911.1 5578.2 5615.8 5633.5 5651.5 5681.7 5765.4 5789.8 5796.7 5817.4 5875.5 5576.9 5710.0 5824.0 5826.6 5835.8 5739.5 5748.6 5770.5 5776.2 5823.9 4371.7 4406.9 4406.9 4412.2 4434.2 3900.9 3915.6 3935.2 3947.0 3972.7 5497.1 5568.1 5574.6 5576.6 5629.6 5835.1 5880.1 5881.2 5890.2 5892.4 5390.0 5554.3 5570.2 5605.1 5628.0 5059.3 5064.1 5071.7 5098.6 5102.8 6147.9 6155.0 6159.4 6160.6 6163.8 5662.8 5814.4 5822.3 5884.1 5899.5 6032.3 6043.4 6066.3 6082.4 6086.5 5540.9 5746.3 5748.7 5752.1 5768.5 5759.0 5771.1 5774.1 5794.6 5798.5 5599.1 5705.6 5708.3 5712.4 5729.5 5448.1 5665.6 5673.7 5684.3 5692.9 5453.3 5513.0 5557.5 5626.4 5757.8 5682.8 5686.4 5693.9 5694.5 5727.3 5380.4 5509.8 5578.9 5586.3 5609.7 20:36:08 INFO - PROCESS | 18248 | 20:36:08 INFO - PROCESS | 18248 | [#1] ext.html Cycles:180 Average:59473.76 Median:231468.79 stddev:117678.37 (50.8%) stddev-sans-first:117925.44 20:36:08 INFO - PROCESS | 18248 | Values: 589.6 626.9 647.6 650.8 667.0 42690.8 43929.0 43995.0 44238.3 47514.0 45144.3 45186.5 45439.8 45605.0 45764.8 8671.8 8894.2 8912.2 8922.5 8924.6 8837.9 8910.6 8924.2 8925.6 8933.0 8837.6 8846.9 8863.9 8905.5 8974.7 8753.9 8832.5 8875.0 8881.8 8891.8 8705.8 8833.1 8843.6 8854.6 8866.1 42411.6 42901.1 42908.8 42929.1 42965.4 3382.3 3629.2 3718.1 3934.2 3946.0 33210.2 33276.0 33318.3 33362.2 35066.6 4448.8 4476.6 4477.1 4501.4 4571.8 365225.0 366829.0 368023.0 369095.0 369190.0 59812.4 60272.4 60349.7 60489.4 60529.0 36263.8 37137.3 37299.3 39216.0 39218.6 15143.5 15167.8 15225.7 15283.3 15284.2 11396.4 11396.7 11403.4 11416.9 11484.5 20030.5 20076.6 20196.8 20288.5 20303.6 7188.9 7292.3 7358.1 7362.9 7473.7 995.4 1112.1 1115.5 1153.0 1159.5 31412.8 32445.7 32472.5 32502.5 33147.5 1102.0 1154.5 1166.4 1188.2 1203.1 16727.7 17291.0 17305.5 17324.6 17500.0 521031.0 521666.0 522793.0 523900.0 524123.0 41004.2 41205.4 41311.6 41608.8 41611.8 1334.7 1388.6 1397.0 1399.5 1409.6 30514.0 31809.7 32050.2 32338.7 32598.3 52603.7 52900.0 52954.0 53043.2 53086.0 421059.0 427605.0 428513.0 432093.0 433334.0 29089.0 29123.3 29270.7 29406.7 29412.0 49591.1 49902.0 50359.2 50501.5 50613.5 41238.6 42301.6 42632.6 42722.8 43534.3 41742.6 41878.6 42482.2 42856.6 43102.8 35202.6 40076.0 40337.6 41493.6 42789.6 36890.0 37535.0 37901.8 38155.2 38350.0 28415.6 28674.0 28719.6 29088.6 29249.6 20:36:08 INFO - PROCESS | 18248 | 20:36:08 INFO - PROCESS | 18248 | [#2] jquery.html Cycles:180 Average:26268.98 Median:2507.05 stddev:69812.86 (2784.7%) stddev-sans-first:69981.67 20:36:08 INFO - PROCESS | 18248 | Values: 396.2 396.7 399.3 403.1 419.3 17632.4 18802.2 19005.9 19317.9 19327.2 18250.8 18291.3 18523.4 18951.9 18967.4 5534.3 5573.1 5742.1 5755.3 5756.4 5652.7 5658.8 5676.1 5676.4 5701.1 5435.6 5569.3 5681.1 5714.3 5715.1 5658.9 5679.8 5681.3 5684.5 5685.3 4911.0 5050.0 5057.1 5061.3 5065.0 21492.4 21804.5 22129.9 22327.6 22335.9 2050.6 2390.5 2623.6 2894.4 2915.4 9476.8 9995.7 10036.2 10270.8 10604.3 1948.7 1960.8 2001.1 2010.9 2021.2 70261.0 74216.3 74580.3 79057.6 79247.0 10304.7 10776.1 10896.6 11009.0 11054.9 14951.6 14962.7 14981.6 15074.9 15092.1 7521.5 7713.5 7776.3 7863.0 7869.8 7291.2 7479.3 7514.5 7572.0 7750.2 4668.1 4676.7 4711.9 4712.9 4746.2 1965.4 1973.8 1977.6 1999.7 2007.6 955.7 970.9 995.0 1032.2 1053.8 18005.9 18338.0 18702.0 18763.4 18796.2 1017.6 1036.7 1042.7 1053.6 1072.2 10313.4 10682.0 10735.2 10742.4 10796.3 408248.0 408846.0 410917.0 443957.0 445245.0 56874.7 58622.0 60198.0 76048.0 94844.0 1005.8 1059.4 1066.5 1072.7 1079.2 16904.9 16994.9 17136.7 17267.7 17394.3 41222.6 42524.1 42930.1 43021.4 43101.4 59259.7 60065.7 60810.0 61224.7 61701.1 8350.5 8521.0 8577.6 8670.2 8758.9 9509.9 13165.0 13212.3 13335.9 13385.7 11082.2 11456.9 11496.5 11595.3 11777.9 11234.2 11426.4 11617.9 11638.8 11804.8 11212.2 11342.9 11499.0 11867.6 11920.2 7211.1 7544.1 7594.1 7858.6 8760.8 11336.3 11391.2 11401.8 11440.4 11660.1 20:36:08 INFO - PROCESS | 18248 | 20:36:08 INFO - PROCESS | 18248 | [#3] mootools.html Cycles:180 Average:5870.44 Median:2616.65 stddev:3352.63 (128.1%) stddev-sans-first:3345.79 20:36:08 INFO - PROCESS | 18248 | Values: 1479.4 1509.4 1662.3 1809.3 1821.4 7875.6 8451.2 8540.2 9160.0 9168.3 8622.7 8816.8 8856.3 8884.7 8906.6 2320.3 2350.5 2356.4 2369.5 2378.2 2264.3 2287.0 2319.9 2325.0 2340.8 2284.1 2294.6 2308.9 2329.5 2334.3 2234.3 2237.7 2247.3 2249.5 2254.0 2230.5 2231.4 2242.0 2244.8 2249.4 8840.0 8874.4 8902.7 8922.7 8931.8 5108.9 5237.3 5240.9 5264.2 5271.4 3416.6 3581.7 3591.0 3645.0 3668.7 1141.2 1156.5 1199.3 1210.6 1214.6 12539.7 12553.6 12581.4 12618.1 12621.7 4761.4 4772.7 4796.7 4802.5 4876.2 10363.7 10424.6 10476.1 10507.9 10538.3 5366.0 5414.0 5429.5 5444.7 5457.2 4378.2 4672.8 4790.2 4823.7 4912.4 3929.4 3966.7 3981.4 4030.8 4105.3 1224.3 1232.5 1239.5 1247.6 1259.6 942.2 997.3 1025.8 1036.3 1043.4 5805.9 5917.5 6193.1 6228.2 6231.2 445.6 456.9 464.3 464.9 471.9 4127.6 4145.4 4158.6 4173.6 4191.9 10708.0 11152.1 11233.3 11237.8 11289.2 10879.8 10982.6 10984.7 10989.7 10997.1 7943.8 8363.2 8436.5 8437.0 8439.4 5955.3 6027.3 6082.7 6192.7 6213.3 9942.0 10191.2 10248.9 10302.6 10303.3 9550.8 9881.4 9955.4 10231.6 10273.1 7661.3 8243.3 8431.0 8525.1 8593.3 8396.4 8404.0 8442.2 8470.7 8498.8 7550.4 7712.4 7719.6 7814.0 8049.0 7689.4 7771.8 7796.3 7800.6 7908.6 7104.4 7132.5 7185.8 7195.5 7202.1 5259.5 5367.7 5423.0 5463.4 5467.2 5158.1 5244.0 5478.8 5523.3 5640.2 20:36:08 INFO - PROCESS | 18248 | 20:36:08 INFO - PROCESS | 18248 | [#4] prototype.html Cycles:180 Average:4871.38 Median:5583.39 stddev:1446.67 (25.9%) stddev-sans-first:1410.14 20:36:08 INFO - PROCESS | 18248 | Values: 337.6 338.5 343.1 344.4 345.9 5467.3 5550.3 5586.6 5626.3 5639.6 5462.3 5532.2 5541.3 5569.4 5570.8 4107.3 4152.3 4316.5 4318.5 4341.5 4300.4 4310.1 4315.3 4341.4 4371.6 4275.7 4297.0 4299.2 4329.1 4354.6 4045.3 4244.7 4274.6 4289.1 4290.5 3717.2 3744.3 3754.8 3757.8 3761.8 5383.6 5388.2 5413.5 5423.7 5432.7 4682.3 4833.2 4864.6 4901.0 4934.3 5700.4 5706.6 5783.2 5788.2 5790.7 3956.9 4000.2 4034.9 4037.1 4075.8 5862.3 6062.6 6066.8 6074.6 6118.5 4182.9 4191.9 4207.0 4212.5 4247.8 4245.2 4261.0 4263.9 4286.8 4296.7 4690.7 4858.3 4875.2 4896.6 4912.2 5799.3 5817.9 5820.4 5827.0 5849.4 1463.6 1465.5 1478.2 1499.0 1501.7 895.2 937.2 938.3 967.5 989.1 5502.4 5528.6 5545.9 5582.3 5599.4 5862.9 5914.6 5949.3 5968.4 5986.6 5374.2 5578.7 5584.4 5589.7 5634.7 3121.3 3134.5 3171.8 3179.0 3186.2 5913.3 6074.1 6127.4 6172.8 6177.9 5968.3 5993.6 6060.6 6063.8 6076.0 6054.5 6075.2 6113.4 6166.0 6202.7 5702.6 5920.8 5922.5 5956.9 5959.8 5797.9 5837.9 5849.4 5859.8 5872.9 6015.9 6141.6 6149.2 6204.3 6218.2 4166.7 4184.9 4203.8 4209.8 4217.8 5965.7 6009.0 6023.2 6039.3 6051.5 5579.9 5721.5 5763.3 5786.9 5841.7 5574.0 5726.4 5739.7 5771.8 5777.9 5504.8 5646.5 5659.5 5700.4 5778.9 5909.9 5933.6 5935.6 5967.2 5987.8 5636.2 5844.6 5844.8 5850.9 5888.6 20:36:08 INFO - PROCESS | 18248 | 20:36:08 INFO - PROCESS | 18248 | [#5] yui.html Cycles:180 Average:15656.50 Median:4828.87 stddev:18871.35 (390.8%) stddev-sans-first:18891.09 20:36:08 INFO - PROCESS | 18248 | Values: 749.8 757.2 806.7 859.4 865.6 13863.8 14721.4 14853.7 16001.0 16100.1 13680.1 13693.9 13708.2 13735.3 13737.2 692.4 814.1 825.2 829.2 829.6 813.2 835.7 835.8 837.0 837.2 873.3 879.9 880.3 881.5 881.6 860.9 863.0 867.3 870.5 873.4 629.4 631.1 632.8 634.2 635.2 14795.9 14840.6 14843.3 14879.8 14890.0 14125.6 14322.0 14394.9 14532.6 14822.3 11579.5 11717.5 11789.9 11815.1 12278.9 3853.1 3853.2 3987.4 4024.6 4067.5 57208.0 57666.7 57774.4 57821.4 57879.7 11155.7 11321.6 11338.8 11364.5 11370.9 20453.1 20464.2 20510.5 20513.0 20514.3 8009.6 8333.3 8342.7 8480.8 8761.6 4828.7 4829.1 4885.0 4929.5 4962.0 3377.8 3473.8 3509.0 3519.4 3522.0 672.2 679.8 680.9 690.6 692.3 609.3 623.6 641.4 745.3 769.6 8736.9 8817.3 8860.3 8987.7 9104.9 689.0 718.3 720.5 720.5 740.3 4098.3 4398.8 4451.7 4487.8 4535.2 67632.0 67687.0 68165.3 68684.7 68767.0 59309.7 59732.0 59890.7 62535.4 63265.1 55877.4 56468.4 57031.4 57464.0 57621.0 8585.4 8654.3 8782.7 8794.0 8964.9 36694.4 36785.8 36822.6 37058.4 37340.8 49207.0 49544.8 50089.2 50123.0 50196.2 10674.5 10781.5 10831.5 11133.4 11434.9 11882.2 11892.0 11940.7 12057.2 12367.6 11135.8 11219.7 11437.9 11609.8 11742.4 10877.6 11109.7 11249.5 11341.3 11682.2 12986.9 13220.4 13265.1 13553.3 13780.0 10974.2 11120.6 11229.2 11259.4 11612.0 11255.3 11385.7 11467.9 11583.0 11715.9 20:36:08 INFO - PROCESS | 18248 | -------- Summary: end -------- 20:36:08 INFO - PROCESS | 18248 | 20:36:09 INFO - TEST-INFO | 18248: exit 0 20:36:09 INFO - TEST-OK | dromaeo_css | took 1110789ms 20:36:09 INFO - TEST-START | kraken 20:36:09 INFO - operating with platform_type : linux_ 20:36:09 INFO - Initialising browser for kraken test... 20:36:09 INFO - TEST-INFO | started process 18485 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjoqEBC/profile http://localhost:35675/getInfo.html) 20:36:13 INFO - PROCESS | 18485 | 20:36:13 INFO - PROCESS | 18485 | (process:18554): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:36:14 INFO - PROCESS | 18485 | __metrics Screen width/height:1600/1200 20:36:14 INFO - PROCESS | 18485 | colorDepth:24 20:36:14 INFO - PROCESS | 18485 | Browser inner width/height: 1024/697 20:36:14 INFO - PROCESS | 18485 | __metrics 20:36:14 ERROR - PROCESS | 18485 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 20:36:15 INFO - TEST-INFO | 18485: exit 0 20:36:15 INFO - Browser initialized. 20:36:15 INFO - Running cycle 1/1 for kraken test... 20:36:15 INFO - TEST-INFO | started process 18605 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjoqEBC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:36:17 INFO - PROCESS | 18605 | 20:36:17 INFO - PROCESS | 18605 | (process:18664): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:36:27 INFO - PROCESS | 18605 | RSS: Main: 167075840 20:36:27 INFO - PROCESS | 18605 | 20:36:30 INFO - PROCESS | 18605 | Cycle 1(1): loaded http://localhost:35675/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35675/tests/kraken/driver.html?testName=audio-beat-detection) 20:36:31 INFO - PROCESS | 18605 | RSS: Main: 171851776 20:36:31 INFO - PROCESS | 18605 | 20:36:33 INFO - PROCESS | 18605 | Cycle 1(1): loaded http://localhost:35675/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35675/tests/kraken/driver.html?testName=audio-dft) 20:36:34 INFO - PROCESS | 18605 | RSS: Main: 171245568 20:36:34 INFO - PROCESS | 18605 | 20:36:37 INFO - PROCESS | 18605 | Cycle 1(1): loaded http://localhost:35675/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35675/tests/kraken/driver.html?testName=audio-fft) 20:36:37 INFO - PROCESS | 18605 | RSS: Main: 166596608 20:36:37 INFO - PROCESS | 18605 | 20:36:39 INFO - PROCESS | 18605 | Cycle 1(1): loaded http://localhost:35675/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35675/tests/kraken/driver.html?testName=audio-oscillator) 20:36:40 INFO - PROCESS | 18605 | RSS: Main: 167575552 20:36:40 INFO - PROCESS | 18605 | 20:36:42 INFO - PROCESS | 18605 | Cycle 1(1): loaded http://localhost:35675/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35675/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:36:43 INFO - PROCESS | 18605 | RSS: Main: 167858176 20:36:43 INFO - PROCESS | 18605 | 20:36:46 INFO - PROCESS | 18605 | Cycle 1(1): loaded http://localhost:35675/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35675/tests/kraken/driver.html?testName=imaging-darkroom) 20:36:47 INFO - PROCESS | 18605 | RSS: Main: 168075264 20:36:47 INFO - PROCESS | 18605 | 20:36:50 INFO - PROCESS | 18605 | Cycle 1(1): loaded http://localhost:35675/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35675/tests/kraken/driver.html?testName=imaging-desaturate) 20:36:51 INFO - PROCESS | 18605 | RSS: Main: 168062976 20:36:51 INFO - PROCESS | 18605 | 20:36:54 INFO - PROCESS | 18605 | Cycle 1(1): loaded http://localhost:35675/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35675/tests/kraken/driver.html?testName=json-parse-financial) 20:36:54 INFO - PROCESS | 18605 | RSS: Main: 168165376 20:36:54 INFO - PROCESS | 18605 | 20:36:56 INFO - PROCESS | 18605 | Cycle 1(1): loaded http://localhost:35675/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35675/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:36:56 INFO - PROCESS | 18605 | RSS: Main: 167895040 20:36:56 INFO - PROCESS | 18605 | 20:36:58 INFO - PROCESS | 18605 | Cycle 1(1): loaded http://localhost:35675/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35675/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:36:59 INFO - PROCESS | 18605 | RSS: Main: 167858176 20:36:59 INFO - PROCESS | 18605 | 20:37:01 INFO - PROCESS | 18605 | Cycle 1(1): loaded http://localhost:35675/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35675/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:37:01 INFO - PROCESS | 18605 | RSS: Main: 168116224 20:37:01 INFO - PROCESS | 18605 | 20:37:04 INFO - PROCESS | 18605 | Cycle 1(1): loaded http://localhost:35675/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35675/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:37:05 INFO - PROCESS | 18605 | RSS: Main: 168525824 20:37:05 INFO - PROCESS | 18605 | 20:37:07 INFO - PROCESS | 18605 | Cycle 1(1): loaded http://localhost:35675/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35675/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:37:08 INFO - PROCESS | 18605 | RSS: Main: 168517632 20:37:08 INFO - PROCESS | 18605 | 20:37:10 INFO - PROCESS | 18605 | Cycle 1(1): loaded http://localhost:35675/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35675/tests/kraken/driver.html?testName=ai-astar) 20:37:10 INFO - PROCESS | 18605 | RSS: Main: 169316352 20:37:10 INFO - PROCESS | 18605 | 20:37:10 INFO - PROCESS | 18605 | __start_tp_report 20:37:10 INFO - PROCESS | 18605 | _x_x_mozilla_page_load 20:37:10 INFO - PROCESS | 18605 | _x_x_mozilla_page_load_details 20:37:10 INFO - PROCESS | 18605 | |i|pagename|runs| 20:37:10 INFO - PROCESS | 18605 | |0;ai-astar;111;110;117;112;116;113;111;111;112;113 20:37:10 INFO - PROCESS | 18605 | |1;audio-beat-detection;160;125;161;187;127;158;150;133;191;125 20:37:10 INFO - PROCESS | 18605 | |2;audio-dft;162;165;165;163;161;165;168;162;162;163 20:37:10 INFO - PROCESS | 18605 | |3;audio-fft;78;76;75;164;76;76;74;74;168;75 20:37:10 INFO - PROCESS | 18605 | |4;audio-oscillator;83;83;152;84;88;84;150;82;84;161 20:37:10 INFO - PROCESS | 18605 | |5;imaging-gaussian-blur;119;117;118;117;117;118;118;120;119;120 20:37:10 INFO - PROCESS | 18605 | |6;imaging-darkroom;147;147;147;151;148;147;147;150;149;147 20:37:10 INFO - PROCESS | 18605 | |7;imaging-desaturate;101;106;95;96;96;95;95;96;100;95 20:37:10 INFO - PROCESS | 18605 | |8;json-parse-financial;60;57;53;53;53;55;55;56;58;53 20:37:10 INFO - PROCESS | 18605 | |9;json-stringify-tinderbox;61;62;62;61;62;61;61;62;63;62 20:37:10 INFO - PROCESS | 18605 | |10;stanford-crypto-aes;82;79;80;82;81;79;82;80;120;80 20:37:10 INFO - PROCESS | 18605 | |11;stanford-crypto-ccm;125;122;122;122;128;121;133;128;145;124 20:37:10 INFO - PROCESS | 18605 | |12;stanford-crypto-pbkdf2;162;161;162;162;167;161;165;163;161;160 20:37:10 INFO - PROCESS | 18605 | |13;stanford-crypto-sha256-iterative;76;65;63;67;63;63;62;69;62;62 20:37:10 INFO - PROCESS | 18605 | __end_tp_report 20:37:10 INFO - PROCESS | 18605 | __start_cc_report 20:37:10 INFO - PROCESS | 18605 | _x_x_mozilla_cycle_collect,895 20:37:10 INFO - PROCESS | 18605 | __end_cc_report 20:37:10 INFO - PROCESS | 18605 | __startTimestamp1464579430388__endTimestamp 20:37:10 INFO - PROCESS | 18605 | 20:37:10 INFO - PROCESS | 18605 | ------- Summary: start ------- 20:37:10 INFO - PROCESS | 18605 | Number of tests: 14 20:37:10 INFO - PROCESS | 18605 | 20:37:10 INFO - PROCESS | 18605 | [#0] ai-astar Cycles:10 Average:112.60 Median:112.50 stddev:2.27 (2.0%) stddev-sans-first:2.33 20:37:10 INFO - PROCESS | 18605 | Values: 111.0 110.0 117.0 112.0 116.0 113.0 111.0 111.0 112.0 113.0 20:37:10 INFO - PROCESS | 18605 | 20:37:10 INFO - PROCESS | 18605 | [#1] audio-beat-detection Cycles:10 Average:151.70 Median:159.00 stddev:24.44 (15.4%) stddev-sans-first:25.73 20:37:10 INFO - PROCESS | 18605 | Values: 160.0 125.0 161.0 187.0 127.0 158.0 150.0 133.0 191.0 125.0 20:37:10 INFO - PROCESS | 18605 | 20:37:10 INFO - PROCESS | 18605 | [#2] audio-dft Cycles:10 Average:163.60 Median:164.00 stddev:2.12 (1.3%) stddev-sans-first:2.17 20:37:10 INFO - PROCESS | 18605 | Values: 162.0 165.0 165.0 163.0 161.0 165.0 168.0 162.0 162.0 163.0 20:37:10 INFO - PROCESS | 18605 | 20:37:10 INFO - PROCESS | 18605 | [#3] audio-fft Cycles:10 Average:93.60 Median:75.50 stddev:38.19 (50.6%) stddev-sans-first:40.08 20:37:10 INFO - PROCESS | 18605 | Values: 78.0 76.0 75.0 164.0 76.0 76.0 74.0 74.0 168.0 75.0 20:37:10 INFO - PROCESS | 18605 | 20:37:10 INFO - PROCESS | 18605 | [#4] audio-oscillator Cycles:10 Average:105.10 Median:83.50 stddev:34.12 (40.9%) stddev-sans-first:35.24 20:37:10 INFO - PROCESS | 18605 | Values: 83.0 83.0 152.0 84.0 88.0 84.0 150.0 82.0 84.0 161.0 20:37:10 INFO - PROCESS | 18605 | 20:37:10 INFO - PROCESS | 18605 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:118.50 stddev:1.16 (1.0%) stddev-sans-first:1.20 20:37:10 INFO - PROCESS | 18605 | Values: 119.0 117.0 118.0 117.0 117.0 118.0 118.0 120.0 119.0 120.0 20:37:10 INFO - PROCESS | 18605 | 20:37:10 INFO - PROCESS | 18605 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:147.50 stddev:1.49 (1.0%) stddev-sans-first:1.54 20:37:10 INFO - PROCESS | 18605 | Values: 147.0 147.0 147.0 151.0 148.0 147.0 147.0 150.0 149.0 147.0 20:37:10 INFO - PROCESS | 18605 | 20:37:10 INFO - PROCESS | 18605 | [#7] imaging-desaturate Cycles:10 Average:97.50 Median:95.00 stddev:3.69 (3.9%) stddev-sans-first:3.69 20:37:10 INFO - PROCESS | 18605 | Values: 101.0 106.0 95.0 96.0 96.0 95.0 95.0 96.0 100.0 95.0 20:37:10 INFO - PROCESS | 18605 | 20:37:10 INFO - PROCESS | 18605 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.50 stddev:2.45 (4.4%) stddev-sans-first:1.92 20:37:10 INFO - PROCESS | 18605 | Values: 60.0 57.0 53.0 53.0 53.0 55.0 55.0 56.0 58.0 53.0 20:37:10 INFO - PROCESS | 18605 | 20:37:10 INFO - PROCESS | 18605 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 20:37:10 INFO - PROCESS | 18605 | Values: 61.0 62.0 62.0 61.0 62.0 61.0 61.0 62.0 63.0 62.0 20:37:10 INFO - PROCESS | 18605 | 20:37:10 INFO - PROCESS | 18605 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:80.50 stddev:12.53 (15.6%) stddev-sans-first:13.25 20:37:10 INFO - PROCESS | 18605 | Values: 82.0 79.0 80.0 82.0 81.0 79.0 82.0 80.0 120.0 80.0 20:37:10 INFO - PROCESS | 18605 | 20:37:10 INFO - PROCESS | 18605 | [#11] stanford-crypto-ccm Cycles:10 Average:127.00 Median:126.50 stddev:7.35 (5.8%) stddev-sans-first:7.76 20:37:10 INFO - PROCESS | 18605 | Values: 125.0 122.0 122.0 122.0 128.0 121.0 133.0 128.0 145.0 124.0 20:37:10 INFO - PROCESS | 18605 | 20:37:10 INFO - PROCESS | 18605 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.40 Median:162.00 stddev:2.12 (1.3%) stddev-sans-first:2.24 20:37:10 INFO - PROCESS | 18605 | Values: 162.0 161.0 162.0 162.0 167.0 161.0 165.0 163.0 161.0 160.0 20:37:10 INFO - PROCESS | 18605 | 20:37:10 INFO - PROCESS | 18605 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:64.00 stddev:4.47 (7.0%) stddev-sans-first:2.50 20:37:10 INFO - PROCESS | 18605 | Values: 76.0 65.0 63.0 67.0 63.0 63.0 62.0 69.0 62.0 62.0 20:37:10 INFO - PROCESS | 18605 | -------- Summary: end -------- 20:37:10 INFO - PROCESS | 18605 | 20:37:11 INFO - TEST-INFO | 18605: exit 0 20:37:11 INFO - TEST-OK | kraken | took 61711ms 20:37:11 INFO - SUITE-END | took 1172s 20:37:11 INFO - Completed test suite (00:19:32) 20:37:11 INFO - javascript benchmark 20:37:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7164.225748953867, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3124.156477751007, 3148.9685103148963, 3174.492081266998, 3178.5867837181163, 3186.64946855846, 5349.384820745616, 5393.4067252602235, 5436.592255580832, 5450.91823622646, 5568.081266591008, 5296.417394086648, 5364.839054828361, 5419.458054194579, 5437.184422336642, 5439.5376393006545, 4921.876953076184, 4945.455999840015, 4981.651284410093, 5098.872528186788, 5137.3064636274, 4914.213725803872, 5116.155834287338, 5139.563137133348, 5141.126008578532, 5144.768485418165, 4902.632302577304, 4928.0, 4964.478729733362, 4987.102321582114, 5011.699298042129, 4965.702057876503, 4966.404031516205, 4969.428515720702, 4971.577415919651, 5037.823676171316, 4939.481354457802, 4953.925691114636, 4957.752112394366, 4958.355413796219, 4993.550580447777, 5143.871403214949, 5284.4187139414635, 5324.5740340772645, 5365.758540865631, 5386.2997810284805, 5828.679422631753, 5847.26909136358, 5849.502792262663, 5851.268591426072, 5879.176915231871, 5672.602917795756, 5874.060150375962, 5877.882442351171, 5881.0, 5898.8820223595285, 5297.12597421425, 5331.680099194022, 5345.465453454663, 5346.385165705955, 5351.1973204019705, 5813.593048486566, 5877.500412464903, 5884.558658100659, 5892.204552385459, 5911.054231322968, 5578.191162281528, 5615.803446879339, 5633.521150702236, 5651.491365777099, 5681.659100453986, 5765.423457654285, 5789.768409263666, 5796.681182535001, 5817.447342502455, 5875.529957603381, 5576.86057848557, 5709.9714501427225, 5824.0, 5826.563007774434, 5835.79574714883, 5739.540836733051, 5748.626339287933, 5770.450538638592, 5776.191333213354, 5823.854403639943, 4371.737695738266, 4406.867793966187, 4406.933895991563, 4412.183746006999, 4434.246178149722, 3900.8829735107993, 3915.5888631693833, 3935.193285376491, 3946.980265098656, 3972.7417717848825, 5497.120460726264, 5568.081266590967, 5574.637648552831, 5576.553875689935, 5629.605927585111, 5835.124731290341, 5880.147378630075, 5881.176635271066, 5890.175375447441, 5892.351841297454, 5389.973050134724, 5554.250176226238, 5570.192322113271, 5605.0751625982075, 5628.0, 5059.316992206079, 5064.11378008847, 5071.746412679425, 5098.617603679739, 5102.846914592568, 6147.907781383283, 6154.969225153845, 6159.384061593894, 6160.599561028519, 6163.753449862045, 5662.7734890603915, 5814.3604203538425, 5822.301323840997, 5884.146798714248, 5899.528037756883, 6032.336442991355, 6043.36544662804, 6066.332703402711, 6082.36135205797, 6086.513078953762, 5540.861478463071, 5746.252987111816, 5748.655080695172, 5752.13717942312, 5768.451997060272, 5758.971205143947, 5771.105478650816, 5774.0761478163295, 5794.594378393472, 5798.536117110537, 5599.132134519156, 5705.62913410627, 5708.315002199763, 5712.371639119777, 5729.455701708331, 5448.128299472065, 5665.5750818689585, 5673.74468148926, 5684.346300175533, 5692.943070569241, 5453.345598528202, 5513.007658621486, 5557.527610153183, 5626.409227031103, 5757.827265182052, 5682.77268909239, 5686.4029276926985, 5693.943060569507, 5694.544436445157, 5727.255456790591, 5380.381256155436, 5509.752061157177, 5578.86052848682, 5586.273784408164, 5609.691466969356], "value": 5360.4844162102245, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.5607772209702, 626.8902941985157, 647.5596594315865, 650.8047585724285, 667.0494545272987, 42690.78654606726, 43929.0, 43995.0, 44238.33642495361, 47514.0, 45144.322835157414, 45186.54813451864, 45439.77280113595, 45605.0, 45764.77117614407, 8671.826563468727, 8894.199522043014, 8912.197902188802, 8922.464652120894, 8924.55377231139, 8837.867431988525, 8910.599023043946, 8924.152205540464, 8925.55372231389, 8933.017368089504, 8837.646494140226, 8846.911530884674, 8863.867041994376, 8905.510196939165, 8974.685885993991, 8753.868691969625, 8832.514211718353, 8874.955625221897, 8881.777955551099, 8891.777705557348, 8705.825883482295, 8833.072527384596, 8843.557822108869, 8854.601542930519, 8866.069062748384, 42411.57588424107, 42901.141977160594, 42908.78545607283, 42929.14141717148, 42965.35551966692, 3382.2897191589796, 3629.219717760694, 3718.1448266898497, 3934.15415685629, 3945.960540394588, 33210.169745756546, 33276.0, 33318.333633327195, 33362.1659458513, 35066.6493335066, 4448.799804008795, 4476.6418686505, 4477.126960242721, 4501.369808226851, 4571.817127314904, 365225.0, 366829.0, 368023.0, 369094.9999999973, 369190.0, 59812.401875980686, 60272.39727602756, 60349.69825150846, 60489.395106048374, 60529.0, 36263.81868090643, 37137.257254854754, 37299.25401491955, 39216.0, 39218.60781392206, 15143.469978550918, 15167.848321516864, 15225.695486090437, 15283.312250948735, 15284.235788210544, 11396.373199473943, 11396.715082122848, 11403.42982850854, 11416.942915285537, 11484.483198256099, 20030.49923751918, 20076.59846803056, 20196.798032019786, 20288.492787680425, 20303.59392812165, 7188.892166617505, 7292.34368906801, 7358.11702595692, 7362.926370736332, 7473.701051957861, 995.4425521707722, 1112.0825319111766, 1115.4701516779628, 1152.9538818447168, 1159.5187996981326, 31412.842935785175, 32445.675543244266, 32472.51291230586, 32502.512462313083, 33147.50278745821, 1102.0357187460972, 1154.468944285638, 1166.3759888459804, 1188.1504724122121, 1203.0916657923212, 16727.665446690997, 17291.0, 17305.480835574952, 17324.566885827957, 17500.0, 521031.0, 521666.0, 522793.0, 523900.0, 524123.0, 41004.1799164021, 41205.38191927123, 41311.586884130775, 41608.791956040026, 41611.791941040705, 1334.652990222549, 1388.632012516704, 1396.958091257264, 1399.5031763723732, 1409.5700811252461, 30514.0, 31809.681903181598, 32050.19874503156, 32338.676613234507, 32598.34803303968, 52603.73698131485, 52900.0, 52954.0, 53043.20435193398, 53086.0, 421059.0, 427605.0, 428513.0, 432093.0, 433334.0, 29089.0, 29123.271918202216, 29270.7072929268, 29406.705932940396, 29412.0, 49591.13165809104, 49902.0, 50359.24461133013, 50501.49498504968, 50613.493865060875, 41238.58761412348, 42301.576984231, 42632.57367426286, 42722.78638606787, 43534.34698479462, 41742.58257417508, 41878.58121418747, 42482.15035699207, 42856.5714342865, 43102.78448607737, 35202.647973520965, 40076.0, 40337.59662403339, 41493.585064148974, 42789.57210427856, 36890.0, 37535.0, 37901.75563745862, 38155.23689526138, 38350.0, 28415.573766393107, 28674.0, 28719.569206461503, 29088.563671545366, 29249.561256581594], "value": 19976.316743136376, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.18979187561416, 396.734188093977, 399.301222859995, 403.10108458138353, 419.287211740042, 17632.38286659967, 18802.15390307436, 19005.904970475127, 19317.903410482926, 19327.226910923564, 18250.817491825077, 18291.268349266014, 18523.351682691107, 18951.905240473814, 18967.430977070675, 5534.280543529356, 5573.052581061219, 5742.138679198112, 5755.280589926259, 5756.366799652035, 5652.689102099383, 5658.830235092933, 5676.148577713335, 5676.403977582357, 5701.059325211335, 5435.619506634537, 5569.331680198382, 5681.062624666925, 5714.342850572196, 5715.057015592422, 5658.943410565904, 5679.772809087632, 5681.261436013312, 5684.516816070639, 5685.346185188715, 4910.975445122787, 5050.0, 5057.140286151363, 5061.342025536694, 5065.037642847848, 21492.355229343146, 21804.45488862775, 22129.889350553305, 22327.553448930932, 22335.888320558457, 2050.6103840270302, 2390.4740956989435, 2623.632691423183, 2894.3921776426973, 2915.3731947631363, 9476.763080922963, 9995.70012899614, 10036.24728145392, 10270.845937310947, 10604.310719803188, 1948.7076938459202, 1960.823525882663, 2001.1195074167465, 2010.8994550272573, 2021.20162535799, 70261.0, 74216.25783742148, 74580.25419745788, 79057.60471197664, 79247.0, 10304.690859274233, 10776.137908967265, 10896.564137434414, 11009.0, 11054.949779770908, 14951.626209344853, 14962.70074598502, 14981.625459363604, 15074.924625376803, 15092.094474331576, 7521.548707077593, 7713.460057796013, 7776.339011184, 7863.0, 7869.803254918558, 7291.197968223491, 7479.252074792586, 7514.47398682087, 7572.0, 7750.224977502317, 4668.089722504079, 4676.672632915664, 4711.882202944886, 4712.9057418851435, 4746.1931471649905, 1965.4202010406964, 1973.822355987968, 1977.555050113713, 1999.7100420438956, 2007.628588711093, 955.6989548292265, 970.8834939807127, 995.0348162282575, 1032.1742605915238, 1053.773438710681, 18005.909970450062, 18338.0, 18702.0, 18763.437096887115, 18796.154173062245, 1017.5980487707315, 1036.7356324137447, 1042.7080417483116, 1053.562771449855, 1072.152999130678, 10313.432761198055, 10682.0, 10735.248532602798, 10742.409167495864, 10796.298240614335, 408248.0, 408846.0, 410917.0, 443957.0, 445245.0, 56874.7156264216, 58622.0, 60198.0, 76048.0, 94844.0, 1005.8088963096989, 1059.3537941855461, 1066.4561073852235, 1072.7210925159516, 1079.2067830144838, 16904.915475422546, 16994.915025424794, 17136.742948856026, 17267.654646907242, 17394.304227830744, 41222.58777412187, 42524.149517010104, 42930.14139717125, 43021.35467968046, 43101.3534796972, 59259.703701481216, 60065.69967150136, 60810.0, 61224.693876530335, 61701.074483883676, 8350.498970061573, 8521.0, 8577.614007369559, 8670.176333248332, 8758.868616970878, 9509.904900950902, 13165.012624053426, 13212.339383031001, 13335.866641333463, 13385.748109371847, 11082.224244303145, 11456.885431145582, 11496.540138394705, 11595.304281743123, 11777.941110294394, 11234.213605047567, 11426.428678565871, 11617.941910290394, 11638.767224655629, 11804.822927656263, 11212.159088068265, 11342.886571134182, 11499.0, 11867.58463453775, 11920.165588408729, 7211.134663840373, 7544.132424771222, 7594.126675432175, 7858.646360913658, 8760.824783504422, 11336.263142895685, 11391.202615816814, 11401.771964560829, 11440.370779607201, 11660.06719462458], "value": 9005.779532904291, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1479.3934486860387, 1509.37360995187, 1662.2686018152012, 1809.2582041363044, 1821.3898344054749, 7875.606219689022, 8451.19713627206, 8540.231379175873, 9159.954200229005, 9168.266538676899, 8622.741317760478, 8816.823663526742, 8856.335774816898, 8884.689035883745, 8906.599203035863, 2320.257517594366, 2350.459394339303, 2356.4108972756812, 2369.490559529701, 2378.21518898763, 2264.2527965771255, 2286.9885650571723, 2319.8724070176136, 2324.9651255231183, 2340.8244381671443, 2284.1434462076722, 2294.6328587426015, 2308.8960996755104, 2329.5224478981854, 2334.3347146063375, 2234.3297010896827, 2237.7202849643795, 2247.3033359658557, 2249.516353983893, 2253.9549209015727, 2230.464688474771, 2231.4198308439923, 2241.9775802241934, 2244.8316376271846, 2249.392663980716, 8840.0, 8874.423162494417, 8902.73291801247, 8922.732318030405, 8931.776705582348, 5108.897822043576, 5237.266782650432, 5240.947590524084, 5264.184051472028, 5271.446498117719, 3416.572928383952, 3581.7492775505725, 3591.048372181374, 3644.9817750911075, 3668.743187976816, 1141.201159188563, 1156.5084838943499, 1199.286424577375, 1210.6307576189347, 1214.5506162719762, 12539.686507837287, 12553.623391298275, 12581.433835477426, 12618.053645976497, 12621.747565048647, 4761.35721677576, 4772.72167335975, 4796.688215265996, 4802.471728109905, 4876.195427754381, 10363.689089327332, 10424.635137770294, 10476.0571548561, 10507.894921050845, 10538.262321637565, 5365.9731701342025, 5413.998410294108, 5429.457054294539, 5444.700541470257, 5457.154141108134, 4378.16814805186, 4672.789724462339, 4790.161721698759, 4823.734694591761, 4912.38595175603, 3929.351656976567, 3966.6628336591134, 3981.41208214657, 4030.7581545107387, 4105.322621767375, 1224.2593231095236, 1232.4946771823688, 1239.5475651387178, 1247.5758242197696, 1259.5528587351541, 942.2179590939504, 997.2670087485692, 1025.8461230815437, 1036.2953191829477, 1043.446973104256, 5805.912911306334, 5917.52659787216, 6193.071039344134, 6228.22147231596, 6231.192770065608, 445.5544455544456, 456.9383133276965, 464.3336811675257, 464.91399091168245, 471.93578480526196, 4127.607877251657, 4145.440365550672, 4158.625723684822, 4173.624373806372, 4191.91616167675, 10708.0, 11152.052075573505, 11233.269837460539, 11237.83143252852, 11289.209755317213, 10879.782404351869, 10982.615608453665, 10984.725381865517, 10989.670309890716, 10997.12023038155, 7943.801404965037, 8363.20549547792, 8436.53599052058, 8436.957815210884, 8439.409241353047, 5955.285365756137, 6027.276726792813, 6082.665453400105, 6192.721327540362, 6213.254409470712, 9941.950290248502, 10191.184705223712, 10248.948755256177, 10302.587896484356, 10303.278770485995, 9550.808983820423, 9881.357711748713, 9955.352902061342, 10231.59073637076, 10273.075423211947, 7661.272179142972, 8243.299319557906, 8430.957845210734, 8525.062243153125, 8593.31253499706, 8396.370272229486, 8404.0, 8442.240198382175, 8470.66117355299, 8498.787530311793, 7550.35821955118, 7712.383009359126, 7719.6140192989005, 7813.960930195312, 8049.0, 7689.3848492121615, 7771.766846994599, 7796.337311328373, 7800.609969501389, 7908.5650289234645, 7104.3961263293195, 7132.465065120033, 7185.784426467214, 7195.46034047459, 7202.099737532809, 5259.500347466985, 5367.651102678314, 5422.972885135549, 5463.371712253142, 5467.17992301158, 5158.148905430562, 5243.973780131075, 5478.753456094406, 5523.309586301712, 5640.182173584889], "value": 4617.429793627449, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.60837428582846, 338.53282470191147, 343.128453727532, 344.3612099555325, 345.9498372735955, 5467.289252397193, 5550.306211723535, 5586.608937374385, 5626.324841019074, 5639.577031722627, 5462.344518657756, 5532.170174473831, 5541.251930989315, 5569.415211402805, 5570.777168913249, 4107.301758701021, 4152.314868046768, 4316.45329255739, 4318.5465526119615, 4341.544137865526, 4300.419443375135, 4310.094880075188, 4315.287977483711, 4341.3705012773125, 4371.562843715619, 4275.722078064916, 4297.0, 4299.183155200518, 4329.112531930962, 4354.608085272325, 4045.3325201341595, 4244.702870799046, 4274.5939135782055, 4289.1421715657, 4290.4636920384955, 3717.200801827593, 3744.315058223783, 3754.7796965986163, 3757.7933213673236, 3761.793101379423, 5383.623146379755, 5388.218708287276, 5413.512783849473, 5423.728813559345, 5432.70120143392, 4682.344471773954, 4833.202521583935, 4864.635152363587, 4900.950990490085, 4934.309196712463, 5700.401457846908, 5706.629069110536, 5783.161441590988, 5788.18965344852, 5790.739416726257, 3956.920861582781, 4000.179963107556, 4034.9394759078637, 4037.0916543777707, 4075.7554546726997, 5862.296524417055, 6062.63624182546, 6066.817995460143, 6074.605150665237, 6118.4799292060225, 4182.853600123981, 4191.8742437726305, 4206.978965105216, 4212.4523811904255, 4247.787610619456, 4245.172191422705, 4260.998665313648, 4263.936040959388, 4286.807093680792, 4296.677749168824, 4690.686607749835, 4858.319835223072, 4875.24433712775, 4896.608271338285, 4912.189488734319, 5799.2750906136735, 5817.88364232713, 5820.447057529528, 5826.970865145732, 5849.385814489502, 1463.5828788795143, 1465.5090544667655, 1478.2460944918168, 1498.9625259368386, 1501.7146742118962, 895.1540793949655, 937.231470194434, 938.3103418987039, 967.5307475874196, 989.1048601016092, 5502.449755024466, 5528.585356098309, 5545.916811247835, 5582.33012038558, 5599.356074051455, 5862.882742345129, 5914.645121292736, 5949.25634295713, 5968.403159683997, 5986.551008674367, 5374.247605335257, 5578.693171875505, 5584.441555844464, 5589.692566908859, 5634.661920284796, 3121.2821051157907, 3134.467140586106, 3171.809691418476, 3178.98410507946, 3186.203449137716, 5913.2608423947, 6074.149619053248, 6127.356627554132, 6172.783952561728, 6177.938220617736, 5968.343482216953, 5993.550483713739, 6060.606060606135, 6063.818085457443, 6075.969620151871, 6054.485368743706, 6075.210222671113, 6113.449789518964, 6165.969170154211, 6202.658853763086, 5702.611211357443, 5920.822375328747, 5922.5261979040715, 5956.851078723066, 5959.821205363846, 5797.884042319214, 5837.854053648693, 5849.356570777126, 5859.824205273849, 5872.911906321323, 6015.879682406415, 6141.570090093651, 6149.2313460817395, 6204.286507051746, 6218.19163508741, 4166.708330416963, 4184.91630167401, 4203.810828512663, 4209.779164042393, 4217.768022758778, 5965.73154208053, 6008.956954635445, 6023.247094113236, 6039.305479869871, 6051.485623722033, 5579.888402231852, 5721.485066344049, 5763.279590051244, 5786.9131963019745, 5841.714822738991, 5573.972130139324, 5726.370099289158, 5739.684317362585, 5771.769129234784, 5777.884442311214, 5504.834854954358, 5646.520045796154, 5659.490645841894, 5700.429957004267, 5778.8844223114465, 5909.85225369352, 5933.584649074523, 5935.614185077956, 5967.224260846062, 5987.7604895805425, 5636.1827535008015, 5844.561657875762, 5844.824655260349, 5850.853728656818, 5888.558358123072], "value": 4406.595367390542, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [749.7825630567135, 757.212499001039, 806.7337778533084, 859.4456575508797, 865.6277800545763, 13863.792043119362, 14721.411143554245, 14853.702925941489, 16001.0, 16100.114493702842, 13680.110792798461, 13693.93153034236, 13708.177509349422, 13735.313234338293, 13737.24445155516, 692.4495026453956, 814.0922870998838, 825.1583384947351, 829.2453866981049, 829.6225217526011, 813.1827513349076, 835.6657337065162, 835.8495470815251, 836.9790755231107, 837.2339309531772, 873.3362644390246, 879.9208071273584, 880.3485420788635, 881.4579033894173, 881.6209030117047, 860.8708693695995, 863.0290922711918, 867.3061550759368, 870.4820631724145, 873.4322690251356, 629.4366541944934, 631.0565704272096, 632.8006677896448, 634.2484156274829, 635.2028204603193, 14795.926020369938, 14840.628984275372, 14843.332050057665, 14879.776803347959, 14890.032147910351, 14125.646858828508, 14322.0, 14394.856051439561, 14532.56402307922, 14822.332995015251, 11579.53681852725, 11717.53129874804, 11789.882101178964, 11815.113866459964, 12278.938605306916, 3853.094522787143, 3853.152306492595, 3987.4218238355274, 4024.5975402459812, 4067.4508941292843, 57208.0, 57666.71166644182, 57774.422255777325, 57821.42178578245, 57879.71060144672, 11155.665330040112, 11321.60374386909, 11338.829917551244, 11364.54541818318, 11370.886291137149, 20453.07961141752, 20464.181432742524, 20510.487237819172, 20513.0, 20514.28200013022, 8009.639566219534, 8333.2916702081, 8342.749717508485, 8480.787980300542, 8761.649534018696, 4828.66199366041, 4829.084097996472, 4885.0, 4929.507049295114, 4961.975190124026, 3377.7973321600784, 3473.756837021435, 3508.9824550877083, 3519.436890097572, 3522.0, 672.2000819025344, 679.7994591595392, 680.8978653202059, 690.6408667492976, 692.2869444472202, 609.3236507476697, 623.6133597169693, 641.4131070070833, 745.3105877063695, 769.6305773228881, 8736.8689469658, 8817.250533704708, 8860.335474839283, 8987.730368088967, 9104.8634270486, 688.9931100689029, 718.3032458515232, 720.4632548751214, 720.4884531982351, 740.2893222506347, 4098.323776576832, 4398.8020539075815, 4451.666125040635, 4487.842925497592, 4535.183666939916, 67632.0, 67687.0, 68165.31834681689, 68684.6565767178, 68767.0, 59309.70345148247, 59732.0, 59890.70054649699, 62535.37464625295, 63265.05102423467, 55877.44122558804, 56468.43531564632, 57031.42968570344, 57464.0, 57621.0, 8585.399022068395, 8654.307655387427, 8782.736517904474, 8794.0, 8964.865527017231, 36694.44958325574, 36785.81607092055, 36822.63177368192, 37058.444123337635, 37340.813295933345, 49207.0, 49544.75227623839, 50089.24866127084, 50123.0, 50196.24705629492, 10674.46627668629, 10781.46036271478, 10831.51258193399, 11133.387663678575, 11434.885651143382, 11882.22765520273, 11892.048636109264, 11940.70148246266, 12057.189509946378, 12367.567135150226, 11135.777284454427, 11219.71950701239, 11437.942810285895, 11609.767804644029, 11742.412879356169, 10877.619283325046, 11109.722256943642, 11249.49377278008, 11341.319520828776, 11682.182247242952, 12986.870131298567, 13220.405081771536, 13265.137766045176, 13553.25457099869, 13780.0, 10974.176936729937, 11120.555177792798, 11229.21395502307, 11259.437028148724, 11612.01297889655, 11255.324680519196, 11385.715357115807, 11467.942660286646, 11583.0, 11715.941420292844], "value": 6890.146260950075, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1546.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 110.0, 117.0, 112.0, 116.0, 113.0, 111.0, 111.0, 112.0, 113.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 125.0, 161.0, 187.0, 127.0, 158.0, 150.0, 133.0, 191.0, 125.0], "value": 151.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 165.0, 163.0, 161.0, 165.0, 168.0, 162.0, 162.0, 163.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 75.0, 164.0, 76.0, 76.0, 74.0, 74.0, 168.0, 75.0], "value": 93.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 152.0, 84.0, 88.0, 84.0, 150.0, 82.0, 84.0, 161.0], "value": 105.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 120.0, 119.0, 120.0], "value": 118.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 151.0, 148.0, 147.0, 147.0, 150.0, 149.0, 147.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 106.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 100.0, 95.0], "value": 97.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 57.0, 53.0, 53.0, 53.0, 55.0, 55.0, 56.0, 58.0, 53.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 61.0, 62.0, 61.0, 61.0, 62.0, 63.0, 62.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 79.0, 80.0, 82.0, 81.0, 79.0, 82.0, 80.0, 120.0, 80.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 122.0, 122.0, 122.0, 128.0, 121.0, 133.0, 128.0, 145.0, 124.0], "value": 127.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 162.0, 167.0, 161.0, 165.0, 163.0, 161.0, 160.0], "value": 162.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 65.0, 63.0, 67.0, 63.0, 63.0, 62.0, 69.0, 62.0, 62.0], "value": 65.2, "unit": "score"}]}]} 20:37:11 INFO - Return code: 0 20:37:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:37:11 ERROR - # TBPL SUCCESS # 20:37:11 INFO - Running post-action listener: _resource_record_post_action 20:37:11 INFO - ##### 20:37:11 INFO - ##### Finished run-tests step (success) 20:37:11 INFO - ##### 20:37:11 INFO - Running post-run listener: _resource_record_post_run 20:37:11 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 538112000; Read time: 12; Write time: 415996 20:37:11 INFO - TinderboxPrint: CPU usage
13.4% 20:37:11 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 20:37:11 INFO - TinderboxPrint: I/O write bytes / time
538,112,000 / 415,996 20:37:11 INFO - TinderboxPrint: CPU idle
8,221.1 (86.6%) 20:37:11 INFO - TinderboxPrint: CPU user
1,218.1 (12.8%) 20:37:11 INFO - TinderboxPrint: Swap in / out
0 / 0 20:37:11 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247263232; Read time: 0; Write time: 256252 20:37:11 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290848768; Read time: 12; Write time: 159744 20:37:12 INFO - Running post-run listener: _upload_blobber_files 20:37:12 INFO - Blob upload gear active. 20:37:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:37:12 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 20:37:12 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:37:12 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:37:12 INFO - (blobuploader) - INFO - Open directory for files ... 20:37:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:37:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:37:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:37:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:37:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:37:13 INFO - (blobuploader) - INFO - Done attempting. 20:37:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:37:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:37:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:37:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:37:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:37:14 INFO - (blobuploader) - INFO - Done attempting. 20:37:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:37:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:37:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:37:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:37:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:37:18 INFO - (blobuploader) - INFO - Done attempting. 20:37:18 INFO - (blobuploader) - INFO - Iteration through files over. 20:37:18 INFO - Return code: 0 20:37:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:37:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:37:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee3a81442b6e441d2d3f0af5c60e85186b95aa314218248c7062a220190160006376c186b8f5ffcd12f1a463deaacf10fb73dfaac50a06fcb2bdd244e7b881f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ef924a2076abc9d87e91861043afea80c43f214d22a71cddaef2d42fcb392cd66140d372e654a646cd4099e7da1bf20f3e86de71dc62b0df4ecba89d78cb998", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/af1fff000925cc0a18ed21edb47a4b87c4742cb0b2591e2558f13fa87b3b6177178b61912038b88a0cbe7ad062f1ceacdf452a9dda9449c012335e76cd974990"} 20:37:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:37:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:37:18 INFO - Contents: 20:37:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee3a81442b6e441d2d3f0af5c60e85186b95aa314218248c7062a220190160006376c186b8f5ffcd12f1a463deaacf10fb73dfaac50a06fcb2bdd244e7b881f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ef924a2076abc9d87e91861043afea80c43f214d22a71cddaef2d42fcb392cd66140d372e654a646cd4099e7da1bf20f3e86de71dc62b0df4ecba89d78cb998", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/af1fff000925cc0a18ed21edb47a4b87c4742cb0b2591e2558f13fa87b3b6177178b61912038b88a0cbe7ad062f1ceacdf452a9dda9449c012335e76cd974990"} 20:37:18 INFO - Running post-run listener: copy_logs_to_upload_dir 20:37:18 INFO - Copying logs to upload dir... 20:37:18 INFO - mkdir: /builds/slave/test/build/upload/logs 20:37:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.300429 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-05-29 20:37:17.312082) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-29 20:37:17.316069) ========= 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=7de08804244eb36560b44971000001c3-1464576464.595091-1281982449 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/sha512/ee3a81442b6e441d2d3f0af5c60e85186b95aa314218248c7062a220190160006376c186b8f5ffcd12f1a463deaacf10fb73dfaac50a06fcb2bdd244e7b881f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ef924a2076abc9d87e91861043afea80c43f214d22a71cddaef2d42fcb392cd66140d372e654a646cd4099e7da1bf20f3e86de71dc62b0df4ecba89d78cb998", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/af1fff000925cc0a18ed21edb47a4b87c4742cb0b2591e2558f13fa87b3b6177178b61912038b88a0cbe7ad062f1ceacdf452a9dda9449c012335e76cd974990"} build_url:https://queue.taskcluster.net/v1/task/JDHg30GISdiIHZo-asFeYA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011396 build_url: 'https://queue.taskcluster.net/v1/task/JDHg30GISdiIHZo-asFeYA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee3a81442b6e441d2d3f0af5c60e85186b95aa314218248c7062a220190160006376c186b8f5ffcd12f1a463deaacf10fb73dfaac50a06fcb2bdd244e7b881f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ef924a2076abc9d87e91861043afea80c43f214d22a71cddaef2d42fcb392cd66140d372e654a646cd4099e7da1bf20f3e86de71dc62b0df4ecba89d78cb998", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/af1fff000925cc0a18ed21edb47a4b87c4742cb0b2591e2558f13fa87b3b6177178b61912038b88a0cbe7ad062f1ceacdf452a9dda9449c012335e76cd974990"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-29 20:37:17.345224) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 20:37:17.345880) ========= 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=7de08804244eb36560b44971000001c3-1464576464.595091-1281982449 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004521 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 20:37:17.428650) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-29 20:37:17.429431) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-29 20:37:17.430110) ========= ========= Total master_lag: 0.17 =========