builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-062 starttime: 1478112495.23 results: success (0) buildid: 20161102081359 builduid: 9ea7e145f2a64a53857cff6bd26d1e8a revision: eb1336d8898f8b84de79b5a9e152ce82ed4fb3df ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-02 11:48:15.228489) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-02 11:48:15.228939) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-02 11:48:15.229227) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-02 11:48:15.244386) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 11:48:15.244716) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1478112494.264922-979874318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-02 11:48:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 65.7M=0s 2016-11-02 11:48:15 (65.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.074234 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 11:48:15.332974) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 11:48:15.333337) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1478112494.264922-979874318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020787 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 11:48:15.383161) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-02 11:48:15.383519) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev eb1336d8898f8b84de79b5a9e152ce82ed4fb3df --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev eb1336d8898f8b84de79b5a9e152ce82ed4fb3df --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=a4ce256d2ec601f24a60a71e000001bc-1478112494.264922-979874318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-02 11:48:15,452 truncating revision to first 12 chars 2016-11-02 11:48:15,452 Setting DEBUG logging. 2016-11-02 11:48:15,452 attempt 1/10 2016-11-02 11:48:15,452 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/eb1336d8898f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-02 11:48:16,350 unpacking tar archive at: mozilla-inbound-eb1336d8898f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.209017 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-02 11:48:16.605656) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-02 11:48:16.605997) ========= script_repo_revision: eb1336d8898f8b84de79b5a9e152ce82ed4fb3df ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-02 11:48:16.606383) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-02 11:48:16.606643) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-02 11:48:16.615094) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-11-02 11:48:16.615388) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1478112494.264922-979874318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:48:16 INFO - MultiFileLogger online at 20161102 11:48:16 in /builds/slave/test 11:48:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 11:48:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:48:16 INFO - {'append_to_log': False, 11:48:16 INFO - 'base_work_dir': '/builds/slave/test', 11:48:16 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 11:48:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:48:16 INFO - 'branch': 'Mozilla-Inbound', 11:48:16 INFO - 'buildbot_json_path': 'buildprops.json', 11:48:16 INFO - 'config_files': ('talos/linux_config.py',), 11:48:16 INFO - 'default_actions': ('clobber', 11:48:16 INFO - 'read-buildbot-config', 11:48:16 INFO - 'download-and-extract', 11:48:16 INFO - 'populate-webroot', 11:48:16 INFO - 'create-virtualenv', 11:48:16 INFO - 'install', 11:48:16 INFO - 'run-tests'), 11:48:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:48:16 INFO - 'download_minidump_stackwalk': True, 11:48:16 INFO - 'download_symbols': 'ondemand', 11:48:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:48:16 INFO - 'tooltool.py': '/tools/tooltool.py', 11:48:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:48:16 INFO - '/tools/misc-python/virtualenv.py')}, 11:48:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:48:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:48:16 INFO - 'installer_path': 'installer.exe', 11:48:16 INFO - 'log_level': 'info', 11:48:16 INFO - 'log_name': 'talos', 11:48:16 INFO - 'log_to_console': True, 11:48:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:48:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:48:16 INFO - 'opt_config_files': (), 11:48:16 INFO - 'pip_index': False, 11:48:16 INFO - 'sps_profile': False, 11:48:16 INFO - 'sps_profile_interval': 0, 11:48:16 INFO - 'suite': 'dromaeojs', 11:48:16 INFO - 'system_bits': '32', 11:48:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:48:16 INFO - 'title': 'talos-linux64-ix-062', 11:48:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:48:16 INFO - 'use_talos_json': True, 11:48:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:48:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:48:16 INFO - 'work_dir': 'build'} 11:48:16 INFO - [mozharness: 2016-11-02 18:48:16.785519Z] Running clobber step. 11:48:16 INFO - Running pre-action listener: _resource_record_pre_action 11:48:16 INFO - Running main action method: clobber 11:48:16 INFO - rmtree: /builds/slave/test/build 11:48:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:48:17 INFO - Running post-action listener: _resource_record_post_action 11:48:17 INFO - [mozharness: 2016-11-02 18:48:17.761397Z] Finished clobber step (success) 11:48:17 INFO - [mozharness: 2016-11-02 18:48:17.761496Z] Running read-buildbot-config step. 11:48:17 INFO - Running pre-action listener: _resource_record_pre_action 11:48:17 INFO - Running main action method: read_buildbot_config 11:48:17 INFO - Using buildbot properties: 11:48:17 INFO - { 11:48:17 INFO - "project": "", 11:48:17 INFO - "product": "firefox", 11:48:17 INFO - "script_repo_revision": "production", 11:48:17 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 11:48:17 INFO - "repository": "", 11:48:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 11:48:17 INFO - "buildid": "20161102081359", 11:48:17 INFO - "stage_platform": "linux64-pgo", 11:48:17 INFO - "basedir": "/builds/slave/test", 11:48:17 INFO - "buildnumber": 2743, 11:48:17 INFO - "platform": "ubuntu64_hw", 11:48:17 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:48:17 INFO - "slavebuilddir": "test", 11:48:17 INFO - "branch": "mozilla-inbound", 11:48:17 INFO - "revision": "eb1336d8898f8b84de79b5a9e152ce82ed4fb3df", 11:48:17 INFO - "slavename": "talos-linux64-ix-062", 11:48:17 INFO - "builduid": "9ea7e145f2a64a53857cff6bd26d1e8a", 11:48:17 INFO - "repo_path": "integration/mozilla-inbound" 11:48:17 INFO - } 11:48:17 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478050521/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 11:48:17 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478050521/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 11:48:17 INFO - Running post-action listener: _resource_record_post_action 11:48:17 INFO - [mozharness: 2016-11-02 18:48:17.763908Z] Finished read-buildbot-config step (success) 11:48:17 INFO - [mozharness: 2016-11-02 18:48:17.763996Z] Running download-and-extract step. 11:48:17 INFO - Running pre-action listener: _resource_record_pre_action 11:48:17 INFO - Running main action method: download_and_extract 11:48:17 INFO - mkdir: /builds/slave/test/build/tests 11:48: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:17 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478050521/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 11:48:17 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478050521/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 11:48:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478050521/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:48:17 INFO - Downloaded 1361 bytes. 11:48:17 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 11:48:17 INFO - Using the following test package requirements: 11:48:17 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 11:48:17 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:48:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:48:17 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:48:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:48:17 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:48:17 INFO - u'jsshell-linux-x86_64.zip'], 11:48:17 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:48:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:48:17 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 11:48:17 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:48:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:48:17 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:48:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:48:17 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:48:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:48:17 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:48:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:48:17 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:48:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478050521/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 11:48:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478050521/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:48:17 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478050521/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 11:48:17 INFO - Http code: 200 11:48:17 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 11:48:17 INFO - x-amz-cf-id: _5KxBty2Iof-V19mmbjNSkDZe_pyBJYsuR_gFBZWiITsDH_iWz4njA== 11:48:17 INFO - x-amz-replication-status: COMPLETED 11:48:17 INFO - x-amz-version-id: X2A_nzleVoO2K5Iw.d_Vh76BPWEDp22c 11:48:18 INFO - Expected file size: 22019580 11:48:18 INFO - Obtained file size: 22019580 11:48:22 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:48:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478050521/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 11:48:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478050521/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:48:22 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478050521/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 11:48:22 INFO - Http code: 200 11:48:22 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 11:48:22 INFO - x-amz-cf-id: smAnI3wKqEBc1OGG-2AtK2QZizOk2mTWgNl4EdG76tgYd4ckdSamaw== 11:48:22 INFO - x-amz-replication-status: COMPLETED 11:48:22 INFO - x-amz-version-id: X2A_nzleVoO2K5Iw.d_Vh76BPWEDp22c 11:48:22 INFO - Expected file size: 22019580 11:48:22 INFO - Obtained file size: 22019580 11:48:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478050521/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 11:48:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478050521/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:48:27 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478050521/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 11:48:27 INFO - Http code: 200 11:48:27 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 11:48:27 INFO - x-amz-cf-id: AxgfxxMr5-G7rLev4XzsQ4abe-OxK_weW_4OyPLciiQJv_QsQcn8mQ== 11:48:27 INFO - x-amz-replication-status: COMPLETED 11:48:27 INFO - x-amz-version-id: mUsA.wpq3JeQmShmXVWqAHMBcvLobPZN 11:48:27 INFO - Expected file size: 14409038 11:48:27 INFO - Obtained file size: 14409038 11:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:27 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478050521/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:48:27 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478050521/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:48:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478050521/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:48:28 INFO - Downloaded 59619030 bytes. 11:48:28 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478050521/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:48:28 INFO - mkdir: /builds/slave/test/properties 11:48:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:48:28 INFO - Writing to file /builds/slave/test/properties/build_url 11:48:28 INFO - Contents: 11:48:28 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478050521/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:48:28 INFO - Running post-action listener: _resource_record_post_action 11:48:28 INFO - Running post-action listener: set_extra_try_arguments 11:48:28 INFO - [mozharness: 2016-11-02 18:48:28.513434Z] Finished download-and-extract step (success) 11:48:28 INFO - [mozharness: 2016-11-02 18:48:28.513661Z] Running populate-webroot step. 11:48:28 INFO - Running pre-action listener: _resource_record_pre_action 11:48:28 INFO - Running main action method: populate_webroot 11:48:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:48:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:48:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:48:28 INFO - '--tppagecycles', 11:48:28 INFO - '7'], 11:48:28 INFO - 'tests': ['tsvgm']}}, 11:48:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:48:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:48:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:48:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:48:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:48:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:48:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:28 INFO - 'talos_options': ['--disable-e10s'], 11:48:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:48:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:48:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:28 INFO - 'talos_options': ['--disable-e10s'], 11:48:28 INFO - 'tests': ['damp', 'tps']}, 11:48:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:28 INFO - 'tests': ['damp', 'tps']}, 11:48:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:48:28 INFO - 'tests': ['dromaeo_dom']}, 11:48:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:48:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:48:28 INFO - 'tests': ['basic_compositor_video']}, 11:48:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:48:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:48:28 INFO - 'tests': ['a11yr', 11:48:28 INFO - 'ts_paint', 11:48:28 INFO - 'tpaint', 11:48:28 INFO - 'sessionrestore', 11:48:28 INFO - 'sessionrestore_no_auto_restore', 11:48:28 INFO - 'tabpaint']}, 11:48:28 INFO - 'other-e10s': {'tests': ['a11yr', 11:48:28 INFO - 'ts_paint', 11:48:28 INFO - 'tpaint', 11:48:28 INFO - 'sessionrestore', 11:48:28 INFO - 'sessionrestore_no_auto_restore', 11:48:28 INFO - 'tabpaint']}, 11:48:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:48:28 INFO - 'ts_paint', 11:48:28 INFO - 'tpaint', 11:48:28 INFO - 'sessionrestore', 11:48:28 INFO - 'sessionrestore_no_auto_restore', 11:48:28 INFO - 'tabpaint']}, 11:48:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:48:28 INFO - 'ts_paint', 11:48:28 INFO - 'tpaint', 11:48:28 INFO - 'sessionrestore', 11:48:28 INFO - 'sessionrestore_no_auto_restore', 11:48:28 INFO - 'tabpaint']}, 11:48:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:48:28 INFO - 'tests': ['a11yr', 11:48:28 INFO - 'ts_paint', 11:48:28 INFO - 'tpaint', 11:48:28 INFO - 'sessionrestore', 11:48:28 INFO - 'sessionrestore_no_auto_restore', 11:48:28 INFO - 'tabpaint']}, 11:48:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:48:28 INFO - 'tests': ['a11yr', 11:48:28 INFO - 'ts_paint', 11:48:28 INFO - 'tpaint', 11:48:28 INFO - 'sessionrestore', 11:48:28 INFO - 'sessionrestore_no_auto_restore', 11:48:28 INFO - 'tabpaint']}, 11:48:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:48:28 INFO - 'tests': ['tsvgx', 11:48:28 INFO - 'tsvgr_opacity', 11:48:28 INFO - 'tart', 11:48:28 INFO - 'tscrollx', 11:48:28 INFO - 'cart']}, 11:48:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:48:28 INFO - 'tsvgr_opacity', 11:48:28 INFO - 'tart', 11:48:28 INFO - 'tscrollx', 11:48:28 INFO - 'cart']}, 11:48:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:28 INFO - 'talos_options': ['--disable-e10s'], 11:48:28 INFO - 'tests': ['tp5o']}, 11:48:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:28 INFO - 'tests': ['tp5o']}, 11:48:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:28 INFO - 'talos_options': ['--disable-e10s', 11:48:28 INFO - '--xperf_path', 11:48:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:48:28 INFO - 'tests': ['tp5n']}, 11:48:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:28 INFO - 'talos_options': ['--xperf_path', 11:48:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:48:28 INFO - 'tests': ['tp5n']}}, 11:48:28 INFO - 'talos.zip': {'path': '', 11:48:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:48:28 INFO - Running post-action listener: _resource_record_post_action 11:48:28 INFO - [mozharness: 2016-11-02 18:48:28.531724Z] Finished populate-webroot step (success) 11:48:28 INFO - [mozharness: 2016-11-02 18:48:28.531811Z] Running create-virtualenv step. 11:48:28 INFO - Running pre-action listener: _resource_record_pre_action 11:48:28 INFO - Running main action method: create_virtualenv 11:48:28 INFO - Creating virtualenv /builds/slave/test/build/venv 11:48:28 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 11:48:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:48:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:48:28 INFO - Using real prefix '/usr' 11:48:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:48:29 INFO - Installing distribute.............................................................................................................................................................................................done. 11:48:31 INFO - Installing pip.................done. 11:48:31 INFO - Return code: 0 11:48:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:48:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:48:31 INFO - Reading from file tmpfile_stdout 11:48:31 INFO - Output received: 11:48:31 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 11:48:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:48:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:31 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 0x7f7578ab3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be2f60>, '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 0x1be3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be41d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1478112494.264922-979874318', '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 11:48:31 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 11:48:31 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 11:48:31 INFO - Using env: {'DISPLAY': ':0', 11:48:31 INFO - 'HOME': '/home/cltbld', 11:48:31 INFO - 'LANG': 'en_US.UTF-8', 11:48:31 INFO - 'LANGUAGE': 'en_US:en', 11:48:31 INFO - 'LOGNAME': 'cltbld', 11:48:31 INFO - 'MAIL': '/var/mail/cltbld', 11:48:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:31 INFO - 'MOZ_NO_REMOTE': '1', 11:48:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:31 INFO - 'NO_EM_RESTART': '1', 11:48:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:31 INFO - 'PWD': '/builds/slave/test', 11:48:31 INFO - 'SHELL': '/bin/bash', 11:48:31 INFO - 'SHLVL': '1', 11:48:31 INFO - 'TERM': 'linux', 11:48:31 INFO - 'TMOUT': '86400', 11:48:31 INFO - 'USER': 'cltbld', 11:48:31 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1478112494.264922-979874318', 11:48:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:31 INFO - '_': '/tools/buildbot/bin/python'} 11:48:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:31 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 11:48:31 INFO - Cleaning up... 11:48:31 INFO - Return code: 0 11:48:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:48:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:31 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 0x7f7578ab3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be2f60>, '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 0x1be3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be41d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1478112494.264922-979874318', '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 11:48:31 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 11:48:31 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 11:48:31 INFO - Using env: {'DISPLAY': ':0', 11:48:31 INFO - 'HOME': '/home/cltbld', 11:48:31 INFO - 'LANG': 'en_US.UTF-8', 11:48:31 INFO - 'LANGUAGE': 'en_US:en', 11:48:31 INFO - 'LOGNAME': 'cltbld', 11:48:31 INFO - 'MAIL': '/var/mail/cltbld', 11:48:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:31 INFO - 'MOZ_NO_REMOTE': '1', 11:48:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:31 INFO - 'NO_EM_RESTART': '1', 11:48:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:31 INFO - 'PWD': '/builds/slave/test', 11:48:31 INFO - 'SHELL': '/bin/bash', 11:48:31 INFO - 'SHLVL': '1', 11:48:31 INFO - 'TERM': 'linux', 11:48:31 INFO - 'TMOUT': '86400', 11:48:31 INFO - 'USER': 'cltbld', 11:48:31 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1478112494.264922-979874318', 11:48:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:31 INFO - '_': '/tools/buildbot/bin/python'} 11:48:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:31 INFO - Downloading/unpacking psutil>=3.1.1 11:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:48:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:48:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:48:33 INFO - Installing collected packages: psutil 11:48:33 INFO - Running setup.py install for psutil 11:48:33 INFO - building 'psutil._psutil_linux' extension 11:48:33 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 11:48:34 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 11:48:34 INFO - building 'psutil._psutil_posix' extension 11:48:34 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 11:48:34 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 11:48:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:48:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:48:34 INFO - Successfully installed psutil 11:48:34 INFO - Cleaning up... 11:48:34 INFO - Return code: 0 11:48:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:34 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 0x7f7578ab3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be2f60>, '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 0x1be3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be41d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1478112494.264922-979874318', '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 11:48:34 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 11:48:34 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 11:48:34 INFO - Using env: {'DISPLAY': ':0', 11:48:34 INFO - 'HOME': '/home/cltbld', 11:48:34 INFO - 'LANG': 'en_US.UTF-8', 11:48:34 INFO - 'LANGUAGE': 'en_US:en', 11:48:34 INFO - 'LOGNAME': 'cltbld', 11:48:34 INFO - 'MAIL': '/var/mail/cltbld', 11:48:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:34 INFO - 'MOZ_NO_REMOTE': '1', 11:48:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:34 INFO - 'NO_EM_RESTART': '1', 11:48:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:34 INFO - 'PWD': '/builds/slave/test', 11:48:34 INFO - 'SHELL': '/bin/bash', 11:48:34 INFO - 'SHLVL': '1', 11:48:34 INFO - 'TERM': 'linux', 11:48:34 INFO - 'TMOUT': '86400', 11:48:34 INFO - 'USER': 'cltbld', 11:48:34 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1478112494.264922-979874318', 11:48:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:34 INFO - '_': '/tools/buildbot/bin/python'} 11:48:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:48:34 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 11:48:34 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 11:48:34 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 11:48:34 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 11:48:34 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 11:48:34 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 11:48:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:48:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:48:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:48:36 INFO - Installing collected packages: mozsystemmonitor 11:48:36 INFO - Running setup.py install for mozsystemmonitor 11:48:36 INFO - Successfully installed mozsystemmonitor 11:48:36 INFO - Cleaning up... 11:48:36 INFO - Return code: 0 11:48:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7578ab3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be2f60>, '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 0x1be3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be41d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1478112494.264922-979874318', '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 11:48:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:48:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:48:36 INFO - Using env: {'DISPLAY': ':0', 11:48:36 INFO - 'HOME': '/home/cltbld', 11:48:36 INFO - 'LANG': 'en_US.UTF-8', 11:48:36 INFO - 'LANGUAGE': 'en_US:en', 11:48:36 INFO - 'LOGNAME': 'cltbld', 11:48:36 INFO - 'MAIL': '/var/mail/cltbld', 11:48:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:36 INFO - 'MOZ_NO_REMOTE': '1', 11:48:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:36 INFO - 'NO_EM_RESTART': '1', 11:48:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:36 INFO - 'PWD': '/builds/slave/test', 11:48:36 INFO - 'SHELL': '/bin/bash', 11:48:36 INFO - 'SHLVL': '1', 11:48:36 INFO - 'TERM': 'linux', 11:48:36 INFO - 'TMOUT': '86400', 11:48:36 INFO - 'USER': 'cltbld', 11:48:36 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1478112494.264922-979874318', 11:48:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:36 INFO - '_': '/tools/buildbot/bin/python'} 11:48:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:36 INFO - Downloading/unpacking jsonschema==2.5.1 11:48:36 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 11:48:36 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 11:48:36 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 11:48:36 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 11:48:36 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 11:48:36 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 11:48:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:48:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:48:38 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 11:48:38 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 11:48:38 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 11:48:38 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 11:48:38 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 11:48:38 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 11:48:39 INFO - Downloading functools32-3.2.3-2.tar.gz 11:48:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:48:39 INFO - warning: no files found matching '*.txt' 11:48:39 INFO - no previously-included directories found matching 'build' 11:48:39 INFO - no previously-included directories found matching 'dist' 11:48:39 INFO - no previously-included directories found matching '.git*' 11:48:39 INFO - Installing collected packages: jsonschema, functools32 11:48:39 INFO - Running setup.py install for functools32 11:48:39 INFO - warning: no files found matching '*.txt' 11:48:39 INFO - no previously-included directories found matching 'build' 11:48:39 INFO - no previously-included directories found matching 'dist' 11:48:39 INFO - no previously-included directories found matching '.git*' 11:48:39 INFO - Successfully installed jsonschema functools32 11:48:39 INFO - Cleaning up... 11:48:39 INFO - Return code: 0 11:48:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:48:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7578ab3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be2f60>, '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 0x1be3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be41d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1478112494.264922-979874318', '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 11:48:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:48:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:48:39 INFO - Using env: {'DISPLAY': ':0', 11:48:39 INFO - 'HOME': '/home/cltbld', 11:48:39 INFO - 'LANG': 'en_US.UTF-8', 11:48:39 INFO - 'LANGUAGE': 'en_US:en', 11:48:39 INFO - 'LOGNAME': 'cltbld', 11:48:39 INFO - 'MAIL': '/var/mail/cltbld', 11:48:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:39 INFO - 'MOZ_NO_REMOTE': '1', 11:48:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:39 INFO - 'NO_EM_RESTART': '1', 11:48:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:39 INFO - 'PWD': '/builds/slave/test', 11:48:39 INFO - 'SHELL': '/bin/bash', 11:48:39 INFO - 'SHLVL': '1', 11:48:39 INFO - 'TERM': 'linux', 11:48:39 INFO - 'TMOUT': '86400', 11:48:39 INFO - 'USER': 'cltbld', 11:48:39 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1478112494.264922-979874318', 11:48:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:39 INFO - '_': '/tools/buildbot/bin/python'} 11:48:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:48:39 INFO - Cleaning up... 11:48:39 INFO - Return code: 0 11:48:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:48:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7578ab3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be2f60>, '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 0x1be3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be41d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1478112494.264922-979874318', '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 11:48:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:48:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:48:39 INFO - Using env: {'DISPLAY': ':0', 11:48:39 INFO - 'HOME': '/home/cltbld', 11:48:39 INFO - 'LANG': 'en_US.UTF-8', 11:48:39 INFO - 'LANGUAGE': 'en_US:en', 11:48:39 INFO - 'LOGNAME': 'cltbld', 11:48:39 INFO - 'MAIL': '/var/mail/cltbld', 11:48:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:39 INFO - 'MOZ_NO_REMOTE': '1', 11:48:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:39 INFO - 'NO_EM_RESTART': '1', 11:48:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:39 INFO - 'PWD': '/builds/slave/test', 11:48:39 INFO - 'SHELL': '/bin/bash', 11:48:39 INFO - 'SHLVL': '1', 11:48:39 INFO - 'TERM': 'linux', 11:48:39 INFO - 'TMOUT': '86400', 11:48:39 INFO - 'USER': 'cltbld', 11:48:39 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1478112494.264922-979874318', 11:48:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:39 INFO - '_': '/tools/buildbot/bin/python'} 11:48:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:39 INFO - Downloading/unpacking blobuploader==1.2.4 11:48:39 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 11:48:39 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 11:48:39 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 11:48:39 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 11:48:39 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 11:48:39 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 11:48:41 INFO - Downloading blobuploader-1.2.4.tar.gz 11:48:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:48:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:48:41 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 11:48:41 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 11:48:41 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 11:48:41 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 11:48:41 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 11:48:41 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 11:48:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:48:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:48:42 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 11:48:42 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 11:48:42 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 11:48:42 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 11:48:42 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 11:48:42 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 11:48:42 INFO - Downloading docopt-0.6.1.tar.gz 11:48:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:48:42 INFO - Installing collected packages: blobuploader, requests, docopt 11:48:42 INFO - Running setup.py install for blobuploader 11:48:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:48:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:48:42 INFO - Running setup.py install for requests 11:48:42 INFO - Running setup.py install for docopt 11:48:43 INFO - Successfully installed blobuploader requests docopt 11:48:43 INFO - Cleaning up... 11:48:43 INFO - Return code: 0 11:48:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:43 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 0x7f7578ab3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be2f60>, '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 0x1be3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be41d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1478112494.264922-979874318', '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 11:48:43 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 11:48:43 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 11:48:43 INFO - Using env: {'DISPLAY': ':0', 11:48:43 INFO - 'HOME': '/home/cltbld', 11:48:43 INFO - 'LANG': 'en_US.UTF-8', 11:48:43 INFO - 'LANGUAGE': 'en_US:en', 11:48:43 INFO - 'LOGNAME': 'cltbld', 11:48:43 INFO - 'MAIL': '/var/mail/cltbld', 11:48:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:43 INFO - 'MOZ_NO_REMOTE': '1', 11:48:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:43 INFO - 'NO_EM_RESTART': '1', 11:48:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:43 INFO - 'PWD': '/builds/slave/test', 11:48:43 INFO - 'SHELL': '/bin/bash', 11:48:43 INFO - 'SHLVL': '1', 11:48:43 INFO - 'TERM': 'linux', 11:48:43 INFO - 'TMOUT': '86400', 11:48:43 INFO - 'USER': 'cltbld', 11:48:43 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1478112494.264922-979874318', 11:48:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:43 INFO - '_': '/tools/buildbot/bin/python'} 11:48:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:48:43 INFO - Running setup.py (path:/tmp/pip-1YQXce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:48:43 INFO - Running setup.py (path:/tmp/pip-O4lTF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:48:43 INFO - Running setup.py (path:/tmp/pip-pwyvui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:48:43 INFO - Running setup.py (path:/tmp/pip-760Dw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:48:43 INFO - Running setup.py (path:/tmp/pip-hIDaWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:48:43 INFO - Running setup.py (path:/tmp/pip-JoTwSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:48:43 INFO - Running setup.py (path:/tmp/pip-47czlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:48:43 INFO - Running setup.py (path:/tmp/pip-YJg3hw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:48:43 INFO - Running setup.py (path:/tmp/pip-_EEdAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:48:43 INFO - Running setup.py (path:/tmp/pip-zkyTYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:48:44 INFO - Running setup.py (path:/tmp/pip-rw3x3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:48:44 INFO - Running setup.py (path:/tmp/pip-z05PRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:48:44 INFO - Running setup.py (path:/tmp/pip-EEQrlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:48:44 INFO - Running setup.py (path:/tmp/pip-JPzBPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:48:44 INFO - Running setup.py (path:/tmp/pip-u1wiOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:48:44 INFO - Running setup.py (path:/tmp/pip-Kds8fm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:48:44 INFO - Running setup.py (path:/tmp/pip-sBVt47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:48:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:48:44 INFO - Running setup.py install for manifestparser 11:48:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:48:44 INFO - Running setup.py install for mozcrash 11:48:44 INFO - Running setup.py install for mozdebug 11:48:44 INFO - Running setup.py install for mozdevice 11:48:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:48:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:48:44 INFO - Running setup.py install for mozfile 11:48:45 INFO - Running setup.py install for mozhttpd 11:48:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:48:45 INFO - Running setup.py install for mozinfo 11:48:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:48:45 INFO - Running setup.py install for mozInstall 11:48:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:48:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:48:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:48:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:48:45 INFO - Running setup.py install for mozleak 11:48:45 INFO - Running setup.py install for mozlog 11:48:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:48:45 INFO - Running setup.py install for moznetwork 11:48:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:48:45 INFO - Running setup.py install for mozprocess 11:48:45 INFO - Running setup.py install for mozprofile 11:48:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:48:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:48:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:48:45 INFO - Running setup.py install for mozrunner 11:48:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:48:46 INFO - Running setup.py install for mozscreenshot 11:48:46 INFO - Running setup.py install for moztest 11:48:46 INFO - Running setup.py install for mozversion 11:48:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:48:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:48:46 INFO - Cleaning up... 11:48:46 INFO - Return code: 0 11:48:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:48:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:46 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 0x7f7578ab3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be2f60>, '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 0x1be3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be41d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1478112494.264922-979874318', '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 11:48:46 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 11:48:46 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 11:48:46 INFO - Using env: {'DISPLAY': ':0', 11:48:46 INFO - 'HOME': '/home/cltbld', 11:48:46 INFO - 'LANG': 'en_US.UTF-8', 11:48:46 INFO - 'LANGUAGE': 'en_US:en', 11:48:46 INFO - 'LOGNAME': 'cltbld', 11:48:46 INFO - 'MAIL': '/var/mail/cltbld', 11:48:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:46 INFO - 'MOZ_NO_REMOTE': '1', 11:48:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:46 INFO - 'NO_EM_RESTART': '1', 11:48:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:46 INFO - 'PWD': '/builds/slave/test', 11:48:46 INFO - 'SHELL': '/bin/bash', 11:48:46 INFO - 'SHLVL': '1', 11:48:46 INFO - 'TERM': 'linux', 11:48:46 INFO - 'TMOUT': '86400', 11:48:46 INFO - 'USER': 'cltbld', 11:48:46 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1478112494.264922-979874318', 11:48:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:46 INFO - '_': '/tools/buildbot/bin/python'} 11:48:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:48:46 INFO - Running setup.py (path:/tmp/pip-aflmWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:48:46 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)) 11:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:48:46 INFO - Running setup.py (path:/tmp/pip-jvJAah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:48:46 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)) 11:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:48:46 INFO - Running setup.py (path:/tmp/pip-cU3aAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:48:46 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)) 11:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:48:46 INFO - Running setup.py (path:/tmp/pip-2XjyU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:48:46 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)) 11:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:48:46 INFO - Running setup.py (path:/tmp/pip-exayR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:48:46 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)) 11:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:48:46 INFO - Running setup.py (path:/tmp/pip-Dy9lMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:48:47 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)) 11:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:48:47 INFO - Running setup.py (path:/tmp/pip-BhjxI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:48:47 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)) 11:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:48:47 INFO - Running setup.py (path:/tmp/pip-IjWNx8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:48:47 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)) 11:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:48:47 INFO - Running setup.py (path:/tmp/pip-6a64IG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:48:47 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)) 11:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:48:47 INFO - Running setup.py (path:/tmp/pip-K3dEuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:48:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:48:47 INFO - Running setup.py (path:/tmp/pip-_u_pwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:48:47 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)) 11:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:48:47 INFO - Running setup.py (path:/tmp/pip-whUDUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:48:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:48:47 INFO - Running setup.py (path:/tmp/pip-R5ByDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:48:47 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)) 11:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:48:47 INFO - Running setup.py (path:/tmp/pip-c0T9Fv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:48:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:48:47 INFO - Running setup.py (path:/tmp/pip-1uAa78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:48:47 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)) 11:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:48:47 INFO - Running setup.py (path:/tmp/pip-vRNg2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:48:47 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)) 11:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:48:47 INFO - Running setup.py (path:/tmp/pip-UGRFUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:48:47 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)) 11:48:47 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)) 11:48:47 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)) 11:48:47 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)) 11:48:47 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)) 11:48:47 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)) 11:48:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:49 INFO - Downloading blessings-1.6.tar.gz 11:48:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:48:49 INFO - Installing collected packages: blessings 11:48:49 INFO - Running setup.py install for blessings 11:48:49 INFO - Successfully installed blessings 11:48:49 INFO - Cleaning up... 11:48:50 INFO - Return code: 0 11:48:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:48:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:48:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:48:50 INFO - Reading from file tmpfile_stdout 11:48:50 INFO - Current package versions: 11:48:50 INFO - argparse == 1.2.1 11:48:50 INFO - blessings == 1.6 11:48:50 INFO - blobuploader == 1.2.4 11:48:50 INFO - docopt == 0.6.1 11:48:50 INFO - functools32 == 3.2.3-2 11:48:50 INFO - jsonschema == 2.5.1 11:48:50 INFO - manifestparser == 1.1 11:48:50 INFO - mozInstall == 1.12 11:48:50 INFO - mozcrash == 0.17 11:48:50 INFO - mozdebug == 0.1 11:48:50 INFO - mozdevice == 0.48 11:48:50 INFO - mozfile == 1.2 11:48:50 INFO - mozhttpd == 0.7 11:48:50 INFO - mozinfo == 0.9 11:48:50 INFO - mozleak == 0.1 11:48:50 INFO - mozlog == 3.4 11:48:50 INFO - moznetwork == 0.27 11:48:50 INFO - mozprocess == 0.23 11:48:50 INFO - mozprofile == 0.28 11:48:50 INFO - mozrunner == 6.12 11:48:50 INFO - mozscreenshot == 0.1 11:48:50 INFO - mozsystemmonitor == 0.3 11:48:50 INFO - moztest == 0.7 11:48:50 INFO - mozversion == 1.4 11:48:50 INFO - psutil == 3.1.1 11:48:50 INFO - requests == 1.2.3 11:48:50 INFO - wsgiref == 0.1.2 11:48:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:48:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:50 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 0x7f7578ab3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be2f60>, '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 0x1be3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be41d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1478112494.264922-979874318', '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 11:48:50 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 11:48:50 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 11:48:50 INFO - Using env: {'DISPLAY': ':0', 11:48:50 INFO - 'HOME': '/home/cltbld', 11:48:50 INFO - 'LANG': 'en_US.UTF-8', 11:48:50 INFO - 'LANGUAGE': 'en_US:en', 11:48:50 INFO - 'LOGNAME': 'cltbld', 11:48:50 INFO - 'MAIL': '/var/mail/cltbld', 11:48:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:50 INFO - 'MOZ_NO_REMOTE': '1', 11:48:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:50 INFO - 'NO_EM_RESTART': '1', 11:48:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:50 INFO - 'PWD': '/builds/slave/test', 11:48:50 INFO - 'SHELL': '/bin/bash', 11:48:50 INFO - 'SHLVL': '1', 11:48:50 INFO - 'TERM': 'linux', 11:48:50 INFO - 'TMOUT': '86400', 11:48:50 INFO - 'USER': 'cltbld', 11:48:50 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1478112494.264922-979874318', 11:48:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:50 INFO - '_': '/tools/buildbot/bin/python'} 11:48:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:50 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)) 11:48:50 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)) 11:48:50 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)) 11:48:50 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)) 11:48:50 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)) 11:48:50 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)) 11:48:50 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)) 11:48:50 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)) 11:48:50 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)) 11:48:50 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)) 11:48:50 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)) 11:48:50 INFO - Cleaning up... 11:48:50 INFO - Return code: 0 11:48:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:48:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7578ab3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be2f60>, '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 0x1be3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be41d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1478112494.264922-979874318', '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 11:48:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:48:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:48:50 INFO - Using env: {'DISPLAY': ':0', 11:48:50 INFO - 'HOME': '/home/cltbld', 11:48:50 INFO - 'LANG': 'en_US.UTF-8', 11:48:50 INFO - 'LANGUAGE': 'en_US:en', 11:48:50 INFO - 'LOGNAME': 'cltbld', 11:48:50 INFO - 'MAIL': '/var/mail/cltbld', 11:48:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:50 INFO - 'MOZ_NO_REMOTE': '1', 11:48:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:50 INFO - 'NO_EM_RESTART': '1', 11:48:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:50 INFO - 'PWD': '/builds/slave/test', 11:48:50 INFO - 'SHELL': '/bin/bash', 11:48:50 INFO - 'SHLVL': '1', 11:48:50 INFO - 'TERM': 'linux', 11:48:50 INFO - 'TMOUT': '86400', 11:48:50 INFO - 'USER': 'cltbld', 11:48:50 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1478112494.264922-979874318', 11:48:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:50 INFO - '_': '/tools/buildbot/bin/python'} 11:48:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:48:50 INFO - Cleaning up... 11:48:50 INFO - Return code: 0 11:48:50 INFO - Running post-action listener: _resource_record_post_action 11:48:50 INFO - Running post-action listener: _start_resource_monitoring 11:48:50 INFO - Starting resource monitoring. 11:48:50 INFO - [mozharness: 2016-11-02 18:48:50.782934Z] Finished create-virtualenv step (success) 11:48:50 INFO - [mozharness: 2016-11-02 18:48:50.783526Z] Running install step. 11:48:50 INFO - Running pre-action listener: _resource_record_pre_action 11:48:50 INFO - Running main action method: install 11:48:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:48:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:48:50 INFO - Reading from file tmpfile_stdout 11:48:50 INFO - Detecting whether we're running mozinstall >=1.0... 11:48:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:48:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:48:51 INFO - Reading from file tmpfile_stdout 11:48:51 INFO - Output received: 11:48:51 INFO - Usage: mozinstall [options] installer 11:48:51 INFO - Options: 11:48:51 INFO - -h, --help show this help message and exit 11:48:51 INFO - -d DEST, --destination=DEST 11:48:51 INFO - Directory to install application into. [default: 11:48:51 INFO - "/builds/slave/test"] 11:48:51 INFO - --app=APP Application being installed. [default: firefox] 11:48:51 INFO - mkdir: /builds/slave/test/build/application 11:48:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:48:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:49:08 INFO - Reading from file tmpfile_stdout 11:49:08 INFO - Output received: 11:49:08 INFO - /builds/slave/test/build/application/firefox/firefox 11:49:08 INFO - Running post-action listener: _resource_record_post_action 11:49:08 INFO - [mozharness: 2016-11-02 18:49:08.080043Z] Finished install step (success) 11:49:08 INFO - [mozharness: 2016-11-02 18:49:08.080314Z] Running run-tests step. 11:49:08 INFO - Running pre-action listener: _resource_record_pre_action 11:49:08 INFO - Running main action method: run_tests 11:49:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:49:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:49:08 INFO - Python 2.7.3 11:49:08 INFO - Return code: 0 11:49:08 INFO - grabbing minidump binary from tooltool 11:49:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:08 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 0x1be2f60>, '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 0x1be3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be41d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:49:08 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 11:49:08 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 11:49:08 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 11:49:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:49:08 INFO - Return code: 0 11:49:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:49:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:49:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:49:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:49:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:49:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478050521/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:49:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478050521/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:49:08 INFO - Using env: {'DISPLAY': ':0', 11:49:08 INFO - 'HOME': '/home/cltbld', 11:49:08 INFO - 'LANG': 'en_US.UTF-8', 11:49:08 INFO - 'LANGUAGE': 'en_US:en', 11:49:08 INFO - 'LOGNAME': 'cltbld', 11:49:08 INFO - 'MAIL': '/var/mail/cltbld', 11:49:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:49:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:49:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:08 INFO - 'MOZ_NO_REMOTE': '1', 11:49:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:49:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:08 INFO - 'NO_EM_RESTART': '1', 11:49:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:08 INFO - 'PWD': '/builds/slave/test', 11:49:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:49:08 INFO - 'SHELL': '/bin/bash', 11:49:08 INFO - 'SHLVL': '1', 11:49:08 INFO - 'TERM': 'linux', 11:49:08 INFO - 'TMOUT': '86400', 11:49:08 INFO - 'USER': 'cltbld', 11:49:08 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1478112494.264922-979874318', 11:49:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:08 INFO - '_': '/tools/buildbot/bin/python'} 11:49:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478050521/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:49:08 INFO - mozversion application_buildid: 20161101183521 11:49:08 INFO - mozversion application_changeset: eb1336d8898f8b84de79b5a9e152ce82ed4fb3df 11:49:08 INFO - mozversion application_display_name: Nightly 11:49:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:49:08 INFO - mozversion application_name: Firefox 11:49:08 INFO - mozversion application_remotingname: firefox 11:49:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:49:08 INFO - mozversion application_vendor: Mozilla 11:49:08 INFO - mozversion application_version: 52.0a1 11:49:08 INFO - mozversion platform_buildid: 20161101183521 11:49:08 INFO - mozversion platform_changeset: eb1336d8898f8b84de79b5a9e152ce82ed4fb3df 11:49:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:49:08 INFO - mozversion platform_version: 52.0a1 11:49:08 INFO - using testdate: 1478112548 11:49:08 INFO - actual date: 1478112548 11:49:08 INFO - starting webserver on 'localhost:57317' 11:49:08 INFO - SUITE-START | Running 2 tests 11:49:08 INFO - TEST-START | dromaeo_css 11:49:08 INFO - operating with platform_type : linux_ 11:49:08 INFO - Initialising browser for dromaeo_css test... 11:49:08 INFO - TEST-INFO | started process 19817 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGOUE8k/profile http://localhost:57317/getInfo.html) 11:49:12 INFO - PROCESS | 19817 | __metrics Screen width/height:1600/1200 11:49:12 INFO - PROCESS | 19817 | colorDepth:24 11:49:12 INFO - PROCESS | 19817 | Browser inner width/height: 1024/697 11:49:12 INFO - PROCESS | 19817 | __metrics 11:49:12 INFO - PROCESS | 19817 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:49:12 INFO - PROCESS | 19817 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:49:13 INFO - PROCESS | 19817 | console.error: PushService: 11:49:13 INFO - PROCESS | 19817 | stateChangeProcessEnqueue: Error transitioning state 11:49:13 INFO - PROCESS | 19817 | UnknownError 11:49:13 INFO - TEST-INFO | 19817: exit 0 11:49:13 INFO - Browser initialized. 11:49:13 INFO - Running cycle 1/1 for dromaeo_css test... 11:49:13 INFO - TEST-INFO | started process 19898 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGOUE8k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:49:26 INFO - PROCESS | 19898 | RSS: Main: 172769280 11:49:26 INFO - PROCESS | 19898 | 11:50:17 INFO - PROCESS | 19898 | 1478112617286 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] 11:52:28 INFO - PROCESS | 19898 | Cycle 1(1): loaded http://localhost:57317/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57317/tests/dromaeo/cssquery-ext.html) 11:52:30 INFO - PROCESS | 19898 | RSS: Main: 344043520 11:52:30 INFO - PROCESS | 19898 | 11:55:32 INFO - PROCESS | 19898 | Cycle 1(1): loaded http://localhost:57317/tests/dromaeo/cssquery-ext.html (next: http://localhost:57317/tests/dromaeo/cssquery-jquery.html) 11:55:33 INFO - PROCESS | 19898 | RSS: Main: 275001344 11:55:33 INFO - PROCESS | 19898 | 11:58:35 INFO - PROCESS | 19898 | Cycle 1(1): loaded http://localhost:57317/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57317/tests/dromaeo/cssquery-mootools.html) 11:58:36 INFO - PROCESS | 19898 | RSS: Main: 215625728 11:58:36 INFO - PROCESS | 19898 | 12:01:38 INFO - PROCESS | 19898 | Cycle 1(1): loaded http://localhost:57317/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57317/tests/dromaeo/cssquery-prototype.html) 12:01:38 INFO - PROCESS | 19898 | RSS: Main: 247427072 12:01:38 INFO - PROCESS | 19898 | 12:04:41 INFO - PROCESS | 19898 | Cycle 1(1): loaded http://localhost:57317/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57317/tests/dromaeo/cssquery-yui.html) 12:04:42 INFO - PROCESS | 19898 | RSS: Main: 218411008 12:04:42 INFO - PROCESS | 19898 | 12:07:45 INFO - PROCESS | 19898 | Cycle 1(1): loaded http://localhost:57317/tests/dromaeo/cssquery-yui.html (next: http://localhost:57317/tests/dromaeo/cssquery-dojo.html) 12:07:45 INFO - PROCESS | 19898 | RSS: Main: 309116928 12:07:45 INFO - PROCESS | 19898 | 12:07:45 INFO - PROCESS | 19898 | __start_tp_report 12:07:45 INFO - PROCESS | 19898 | _x_x_mozilla_page_load 12:07:45 INFO - PROCESS | 19898 | _x_x_mozilla_page_load_details 12:07:45 INFO - PROCESS | 19898 | |i|pagename|runs| 12:07:45 INFO - PROCESS | 19898 | |0;dojo.html;3052.832094234817;3070.6315242170945;3105.4875945469;3122;3124.1720943949845;5228.111221092414;5271.130263506527;5337.066013447646;5395.136778115502;5418.972905135473;5324.5740340772745;5328.46715328467;5332.493413125757;5338.3860856001575;5342.1452567589195;4811.4226292844905;4840.443349014856;4854.902901941959;4883.4628190898975;4887.120318342697;4930.630202734809;4943.382077240345;4959.404871415435;4964.776585053663;4969.875753106165;4873.756312184394;4893.8287159949405;4942.357493525855;4942.579880710144;4971.4034315882145;4956.578690811285;4958.429780575244;4978.253262010728;4978.950210497885;5043.646944713872;4759.048190361941;4788.664793464459;4797.71213727174;4874.122657921573;4885.60915126789;5299.443558426348;5311.840644780663;5317.973410132925;5331.040412725708;5394.460553944614;5627.127795191752;5688.374278829326;5700.087985922232;5700.800471983461;5702.2301989231755;5584.832455026356;5633.60564760467;5690.430956904318;5753.654780713171;5822.417758224144;5314.813981510667;5342.893142137135;5345.919811202835;5400.405955344909;5409.864753381197;5824.417558244227;5830.76676932918;5831.446012628793;5837.416258374129;5840.707964601753;5405.21624364465;5520.006398848246;5600.719964001783;5605.747741351649;5614.831555053355;5692.31692196939;5700.059490184073;5735.684537350486;5742.31092268922;5813.709314534256;5660.801871934463;5709;5711.657300561979;5721.456461636138;5729.5702822288495;5543.501084902378;5731.168980497804;5734.569907256972;5738.799142030092;5741.712914354265;4338.023944612437;4389.868303950887;4410.713303635253;4450.310201918708;4453.710508816916;3942.64516193544;3943.152222272225;3961.960380396159;3990.880273591797;3996.6003399659803;5481.342238931354;5481.424450432647;5492.148716948879;5493.093639549509;5544.86330302287;5585.720713964285;5623.240862483594;5685.77256909719;5702;5795.507381872504;5393.352797664305;5407.405185429599;5411.512963833274;5458.6724796512335;5484.561235101182;4960.379952505937;4966.925496117561;4968.254761785689;4986.725730084808;4987.451380348159;5605.299337582802;5706.629069110661;5708.828735137787;5896.174535565025;5905.881882362414;5678.630888992202;5729.942700573108;5777.335606405317;5792.768289268382;5823.505002074701;5953.464188223081;5953.821385358447;5954.910676339945;5955.106733989936;5972.790952316648;5561.860953476195;5582.385937546947;5597.692126933058;5634;5641.5204707600315;5502.532284755841;5507.146392309199;5603.915941260966;5646.943530564642;5682.6306290091015;5589.832305030855;5593.888122237614;5600.047991841316;5604.159376093618;5619.129034999582;5573.331200255995;5589.916151257653;5636.408177141341;5637;5638.4925356718095;5441.183822426668;5541.584381171348;5554.166874968625;5590.329160500766;5612.943870561406;5655.858603534944;5656.830295091154;5661;5698.572607054404;5703.116017017369;5279.788808447773;5308.522232998894;5318.468153184651;5512.889742205053;5530.557555395479 12:07:45 INFO - PROCESS | 19898 | |1;ext.html;543.9727065959058;588.8174665853585;603.4779915373201;619.6777675608683;634.853983583776;31507.527387089212;43023.78488107559;43527.782361088226;43762;43772.12455750887;43432.348514772304;43655.3451698224;43689.975652799934;43875.56124438754;44120.3381949271;7940.36477081835;8132.105468398471;8702.173293537104;8922.821543569125;8982.64069437225;10315.690529284133;10606.840897386546;10616.522256498438;11099.889001110007;11141.888581114166;10803.243772935897;10868.130549556017;10890.727731806688;10894.237403381767;10894.618688345909;10705.411202383866;10723.03492685662;10759.515821788038;10760;10776.19178561611;10593.576256949713;10653.946730266376;10663.093637040862;10669.893301066968;10673.786524269548;41666.1666766666;41948.79025604883;42025.78987105045;42068.78965605183;42105.157896842196;3410.539577157077;3450.3271861986923;3625.800580968046;3640.10817349751;3650.7809531428197;30984.690153098407;31164.844175778977;31359.37281254385;32287.354252915044;33512.664873351445;3800.448934904451;3953.604639536052;3967.1668949520636;4028.5769994150487;4106.7125301228925;318919;320323.3983830089;320879;321625;321737;34160;35204.64795352065;55971;56303.71848140733;56321.7183914086;36611;36692.63307366892;36823.26353472916;36913.81543092321;36921.26157476889;13509.932450337685;13573.389197486136;13589.52436664712;13615.659608509668;13617.795733064011;10051.195904327637;10225.284230103971;11179.385133817555;11311.886881131084;11469.827952580717;8541.701040463555;8575.356848236408;8619.741407757778;8670.132986701405;8680;3313.685199906005;3341.4820702791108;3370.79775213488;3375.645557216506;3408.0457471907907;974.4835237324229;1001.9248556358302;1023.3910823060268;1055.693848783844;1077.617445806743;31268.37463250768;31363.215919602193;31418.37163256722;31421.214469637984;31942.840285798422;1103.906167975715;1158.472894832849;1169.9590514332128;1176.9588064417703;1210.189173253922;16613.74710440124;16652.50042498727;16778.244978975974;16878.156092195342;17127.314907403565;465485;468638;470356;470840;471450;56759.71620141873;57165;57380.71309643425;57451.42548574544;57551.424485755444;1226.05593692856;1250.7498500299976;1331.3542931677935;1341.9932900335436;1380.42712274407;26695.33261668474;31831.522527161647;32096.358072837946;32243.193920152185;32453.350932980735;48354.51645483641;48866;48867;48899.51100489092;48970.51029489802;336333;336741;337536;338304;338670;24399.634005490287;24892.875535622206;26754.59868102019;27248.455030899666;28669.28326791847;39990;45814.31278530892;46057.30914036225;46477.53522464732;46562.30156547587;38658.2268354637;38760.418593720555;39352.21295574015;39426;41012.38481422721;38269.617303826606;38945.41581876217;39255.41116883306;39606.80196598999;39986;39491;39961;40065.1986960265;40437.98905027398;40883;32764.836175818968;35760.821195893855;36221.63778362288;36558.086047849014;36758.44862327121;26936.461270774867;27658.308542286602;27689.861550692116;27851.44297114006;27895.860520697268 12:07:45 INFO - PROCESS | 19898 | |2;jquery.html;369.3020191837428;380.42175892643183;380.89525380520337;380.92000679857233;383.77165586476036;18710.812891871075;18997;19273.614527709455;19376.9031154844;19403.805961940376;18506.722399164024;18582;18956.526086847836;18959.715604265948;18965.14656840442;5470.8085217017215;5562.332520097584;5812.82561523155;5821.8835623287505;5835;5628.774849006035;5677.8580535486735;5735.713214339266;5742.138679198112;5742.253507044078;5417.891642167155;5594.272744543204;5654.434556544354;5657.094864821629;5705.800296989606;5582.720863956806;5628.887422251532;5637.379888212273;5637.887242255173;5648.830535083954;4986.601071914238;5041.521055499722;5041.647084704072;5046.167382381939;5104.05574968632;22513;22538.323850284516;22545.549089018292;22886.198983035512;23026.76973230263;2192.215094283191;2315.8494697844753;2418.4316685578874;2619.4368210834573;2651.4299425623585;14058.156510609397;14191.503297384543;14192.787108193384;14274.500392486214;14964.551063468114;1863.5341164708823;1864.5059059349283;1877.633861397028;1947.3476385410904;1953.7753158386824;77076;78570.21429785629;79455.6027219866;80130.19869801344;80858.59570702109;10004.349717268355;10190.592376305012;10326.277160598685;10328.948355258175;10632.627858024933;14519.201443920474;14525.636859078608;14530.927345363418;14532.782008269884;14555.854441455662;7585.658645360862;7806.57063861493;7924.801879953047;8052.315553178046;8157.428979971463;7624.5425274483705;7846.8430631387055;7978.6808527659405;8095.5142691438705;8193.95903020493;6239.220097487814;6370.331115232834;6389.361063893573;6434.292227854932;6652.334766523406;1806.97289540657;1867.1224524473475;1867.6731571975122;1894.8957807320453;1896.099352807433;448.6406189246588;728.6903066196951;837.409626213518;947.0387556630026;1062.4900047977014;11070.501827417786;11255.66233013011;11869.525218991144;12048.698782530508;12536.874631253571;447.3692094147237;450.9549045095464;451.61612629265517;452.93432452294235;463.1408736793267;6406.647634380154;6484.059811327331;6540.50946179029;6553.901691474632;6563;454388;455908.4523589339;458377;460733;462224;93190.53404732933;94972.52513737525;96682;98175.50912245394;101867;461.1514812744566;467.1078240560513;468.5197672385832;469.3312030356728;469.72051629280526;10770.461476925966;10923.945380273048;11046.944765276123;11057.83413248818;11176.776464470828;41763;41848;41907.79046104872;42010.78994605008;42584;52547.73726131345;53039;53049.734751325996;60961.69519152376;62790;8397.95801020991;8485.872711909204;8657.134286571292;8731.126887311219;8803.119688031145;12655.87344126547;13455.46178152863;13595.796063058864;13755;13826.239556824068;11558.47986840611;11845.348505832262;11970.461329240032;12008.699782505508;12442.813357799821;11164.776704465703;11174.441277935908;11363.318200907972;11533.538658453568;11799.410029498318;11697.532098716296;11822.527098915947;11843;12346.320952347707;12397.318147501974;8544.487330760174;8657.108733565767;8708.390412671051;8818.91181088181;9029.187373136449;11122.61070862516;11480.770384592095;11760.176787624785;11895.583654572049;11978.76042479163 12:07:45 INFO - PROCESS | 19898 | |3;mootools.html;1438.7338342406656;1466.4427517543336;1581.2014932459106;1734.6877562038844;1772.4239622122814;7282.745103921364;7595.12656044555;7852.450328477002;8387.664493420263;8402.20179082987;7734;8023.759287221378;8028.3978701597325;8233.752987410373;8238.752837414871;2310.8266879983985;2337.1703045418885;2337.345543247885;2338.0414030247603;2341.613633750429;2043.1316690406518;2122.586095711337;2299.8045166160814;2357.3988632898586;2363.456405026845;2229.108356657334;2306.9884650576723;2308.0998410619873;2321.5472982768365;2327.650852372149;2300;2300.815934725218;2329.569029729497;2340.5318936212657;2342.0982921575314;2330.8718020508863;2337.9181728639587;2362.8109751219863;2369.040538581877;2371.537550177716;8162.959185204096;8285.088640249567;8288.751337459886;8310.70912518065;8341.20758527945;4909.828156014522;5042.899142017139;5054.064997975386;5054.772535235923;5059.215821547666;3191.9112763344724;3272.836358182105;3299.4390953537954;3334.483155110962;3390.762646614738;939.4034787909726;990.8166989106966;1002.9749256268578;1026.702256345659;1026.7792424628667;11202.103831693445;11276.605318813885;11278.492467838885;11279.097672186206;11279.605213817476;4242.575742425733;4491.842785502492;4506.278995360792;4610.124076425535;4622.930656040162;9619.422834629944;9645.131938125462;9647.421154730739;9649.179819715402;9657.275704322063;5082.695038297714;5089.872753181126;5095.949040509621;5097.235414687752;5106.208537676666;4515.458145022619;4642.628589712815;4645.790939407735;4695.272232803853;4732.929006064912;3771.9245615087543;3792.1467669774634;3812.1422679897355;3908.8078136168174;3923.7449565778134;1176.4353708914648;1215.2890559023072;1246.7007918099591;1261.9147533121509;1266.3731452930674;802.2899733735686;877.3902138014018;930.6784366200012;941.1294552538874;946.6166202687922;5621.100623900156;5675.914861277084;5731.828045158652;5760.683162426107;5898.085796701518;919.3013309884402;921.15714121578;928.5496534180917;945.5177859291811;950.2160717408028;3896.5518965318784;3987.0829709167056;4076.8573099941955;4082.4692789937712;4179.97910010448;8905.866412003825;9118.452892826452;9201.493917834583;9204.677836275698;9214.677486287948;9050.09499050103;9141;9157.862632060524;9169.449833009907;9175.403598766192;7759.7672069838;7892.565908875067;7899.131095579482;7905.841883162419;7922.326602238759;5516.696581687886;5526.917096243479;5611.551075913999;5620.803271885465;5771.59598828078;9208.079192080739;9226.446413215228;9258.583363748783;9337.299702522203;9365.719028429157;8760.824783504167;9036.141566551167;9042.095790420904;9370.062993700576;9382.765430864283;7298.4891057625455;7484.887726684213;7486.326230639269;7489.063867016623;7489.775306740807;7921.841563168589;7934.960325198337;7994.640241189277;7996.800079997814;8004.919950800418;7052;7109;7193.748218812317;7407.851842963003;7597.468177227541;6904;6964.965175174092;7082.964585177041;7194.676239569337;7226.674799633924;6455.160829092376;6456.838579035561;6507.089007539043;6513.088167656437;6527.67361631926;4940.086084074458;5012.373453318335;5063.949360506348;5176.1200595898035;5192.662476938987;4813.879653008703;4866.926996095132;5082.33929589151;5085.262636917701;5147.3308469898675 12:07:45 INFO - PROCESS | 19898 | |4;prototype.html;304.13928582112624;314.7702177410489;315.8310303987367;319.3804020200811;320.2426261890628;5050.84847454576;5215.713135777531;5219.84340469786;5242.973785131078;5274.393444753854;5059.569936555397;5078.695278283296;5105.412877519087;5113.897722045557;5141.742912854352;4013.7190396672245;4034.4553485279407;4042.4138499917494;4043.939340909896;4075.8981025474304;3788.48855404521;3808.295465338921;4055.71609987301;4061.2689715851134;4063.4514340564087;4024.376221685629;4037.798110094498;4042.4744783178294;4050.5544390117066;4053.9594604053877;4029.254587901218;4033.636972672459;4047.352423612208;4050.4734384530116;4057.8985525361954;3596.8381422835773;3602.7658202217035;3603.6396360364015;3603.8467690339103;3606.242689035306;4933.580645645088;5014.824481143142;5016.3227964224725;5019.949800501985;5020.799168033274;4568.634509239253;4571.2457444521615;4584.885377865547;4587.839425620121;4604.194266003436;5082.263071854561;5374.301340825707;5384.461553844584;5385.434529374437;5390.973045134789;3821.6560509554274;3844.0774214188673;3845.1348446599573;3848.5766565677754;3850.8267127979307;5575.275214222166;5595;5596.4403559644115;5604.570834437192;5626.381098079167;3933.1543718100747;3939.881803545898;3941.3299739044432;3949.6445319921345;3955.861544845974;3839.434606527427;3957.3074711925296;3979.442877997025;3988.703671306837;4007.1184339445276;4552.863414097583;4560.771961401917;4577.793999270041;4581.770911454414;4583.175028494837;5408.864778380494;5424.783008679608;5428.83713488596;5432.320959880015;5440.484397949692;1321.6585166056461;1370.451819272299;1373.4712135827779;1382.7303675783328;1386.9375878085511;851.1871163039283;867.3971589745066;877.1973644115691;882.298572634757;883.6112110671284;4602.792874320664;4638.84293803383;4644.117617652635;4647.86056418308;4648.28075575792;4841.782119804618;4846.825329409243;4864.708117512961;4866.853994380174;4881.435857473274;4617.769111544477;4651.953480465219;4656.278276867091;4668.463126740468;4674.392328997209;2788.2611108055976;2963.199936017263;2963.422132684149;2967.124698214032;2971.93010516214;5745.827625171251;5768.826935191951;5789.884202316014;5792.0732682771395;5797.420257974253;5500.614956952975;5636.408177141341;5688.606291458619;5696.572757043238;5708.80019199326;5750.5112065474905;5756.5682573807135;5766.884662306814;5770.682612456188;5775.249217601769;5569.888602227852;5570.108782594765;5605.915911261252;5606.579506536945;5612.260199338219;5306.814261500829;5447.494152689807;5505.394406615349;5512.200730894078;5520.309961254843;5690.402507736793;5733.684647344436;5763.337216220189;5767.8558036049435;5835.912461313169;3732.4401339799247;3833;3914.4715463412076;3935.3900145477496;3937.31097058008;5410.783568657367;5498.917516237339;5513.8345849624575;5527.176031909541;5544.390117087037;5319.680819150709;5366.570674345965;5405.486463790145;5406.21609866575;5426.158945363475;5245.763940622604;5384.865378365415;5404.783923617312;5411.458854114557;5415.458454154553;5391.433899440659;5412.7564259607625;5413.7834486620095;5421.349438067457;5423.860989192314;5441.782328706808;5449.3460784706085;5450.645708028966;5479.315085614298;5487.75305111263;5101.862354651788;5310.309659744208;5327.280817089643;5328.7602057906715;5359.544438722753 12:07:45 INFO - PROCESS | 19898 | |5;yui.html;702.8840241360174;726.1213931143319;734.4454936522924;815.5799763121997;817.5013241922428;15471;16305;16330.51008469745;16350.182490875439;16401.097939613315;14716.558503244893;14866.851331486681;14870.851291487083;14872.58710422511;14915;661.0711949710665;679.6907407129769;801.791534201109;808.5229714468462;831.55096248026;816.2490508731951;828.4283844147519;829.2412442615;829.4608504472081;830.3647709502236;868.2316150207081;868.4138206710445;869.0397111192136;869.3088994249587;870.2211520689011;691.5470366909632;710.9324614161646;844.1389782421957;866.2463656618751;866.2550206822128;635.3551145587232;637.6206157336377;638.7221558622015;641.470786601056;641.9967900160469;15035.774463383059;15063.096214227182;15064.246787660573;15066.548003559801;15067.849321506754;14290.785638215435;14292.857071429256;14362.712745745132;14380.784288235685;14457.638559036002;12422.689432764162;12447.128700990934;12557.121001529897;12751;12835.87164128356;4420.270655341897;4431.423914891076;4475.552444755531;4552.089582083597;4721.102990431807;67497;67554.32445675578;67921;68600.6569967152;69101.30898691049;11476.827847582294;11526.635539469413;11543.307401555934;11658.242214256046;11675.941620291844;21047.8947605261;21104.472388190417;21125.049372778263;21154.15383384678;21170.682439763415;8031.196880312039;8091.109977902426;8133.064697559738;8151.755447336589;8261.545614991113;4481.865544033684;4558.430196225472;4567.246404343313;4581.129585378834;4586.541345865454;3280.311134661748;3373.0555444475585;3382.458806590983;3388.6272510023878;3389.254364039907;587.1691556447579;589.3929252869551;597.8834127345126;606.6845240475017;611.1016805296207;571.928508936383;608.6621924831761;648.6582989084882;654.8395643067383;658.6015460646336;8187.6081066218885;8301.83396332082;8363.58182090893;8648.654053837776;8710.172533609297;581.3517927510795;626.3329554024949;660.8116686744255;685.7462738786581;688.7653830885232;4201.873943781691;4249.213895429293;4289.785510724514;4365.497967733688;4417.514073451917;52022.739886300325;65376;80775.59612202019;83243.88730296637;89897.55051224702;47018.5298147021;54210.72894635502;64929;68062;74221;67496;68487;68845.65577172082;69868.6506567464;71819.28180718127;7569.735059273119;8065.83868322642;8107.878381824159;8342.165783421851;8539.274161696325;45379.319310209714;45598.31602525898;46824.531754682015;46986.76506617445;48121.75939120282;58081.70959145177;58839.41160588339;59683.70158149181;60807;62434.37565624285;10904.291221070605;10923.890761092287;11037.227394082338;11667.708307292385;11754.29474231549;12208.413143866643;12278.386080695751;12293.56972505958;12460.065495087723;12745.299008554619;11509.424528773696;11514;11702.4733886977;11870.52517899309;12370.690732731753;11308.208425410143;11318.32090074598;11689.590864319707;11828.763424731285;12050.578229761917;10857.457127143769;11276;11469.655910322703;13304.733905322033;13386.531471398454;10007;10109.443980581138;10419.687409377731;10641.787164256826;10823.242373033812;10629.468526573795;10861.945690271814;10906.454677266263;10957.671269861918;11761.235519691192 12:07:45 INFO - PROCESS | 19898 | __end_tp_report 12:07:45 INFO - PROCESS | 19898 | __start_cc_report 12:07:45 INFO - PROCESS | 19898 | _x_x_mozilla_cycle_collect,1714 12:07:45 INFO - PROCESS | 19898 | __end_cc_report 12:07:45 INFO - PROCESS | 19898 | __startTimestamp1478113665325__endTimestamp 12:07:45 INFO - PROCESS | 19898 | 12:07:45 INFO - PROCESS | 19898 | ------- Summary: start ------- 12:07:45 INFO - PROCESS | 19898 | Number of tests: 6 12:07:45 INFO - PROCESS | 19898 | 12:07:45 INFO - PROCESS | 19898 | [#0] dojo.html Cycles:165 Average:5313.84 Median:5520.01 stddev:584.77 (10.6%) stddev-sans-first:559.01 12:07:45 INFO - PROCESS | 19898 | Values: 3052.8 3070.6 3105.5 3122.0 3124.2 5228.1 5271.1 5337.1 5395.1 5419.0 5324.6 5328.5 5332.5 5338.4 5342.1 4811.4 4840.4 4854.9 4883.5 4887.1 4930.6 4943.4 4959.4 4964.8 4969.9 4873.8 4893.8 4942.4 4942.6 4971.4 4956.6 4958.4 4978.3 4979.0 5043.6 4759.0 4788.7 4797.7 4874.1 4885.6 5299.4 5311.8 5318.0 5331.0 5394.5 5627.1 5688.4 5700.1 5700.8 5702.2 5584.8 5633.6 5690.4 5753.7 5822.4 5314.8 5342.9 5345.9 5400.4 5409.9 5824.4 5830.8 5831.4 5837.4 5840.7 5405.2 5520.0 5600.7 5605.7 5614.8 5692.3 5700.1 5735.7 5742.3 5813.7 5660.8 5709.0 5711.7 5721.5 5729.6 5543.5 5731.2 5734.6 5738.8 5741.7 4338.0 4389.9 4410.7 4450.3 4453.7 3942.6 3943.2 3962.0 3990.9 3996.6 5481.3 5481.4 5492.1 5493.1 5544.9 5585.7 5623.2 5685.8 5702.0 5795.5 5393.4 5407.4 5411.5 5458.7 5484.6 4960.4 4966.9 4968.3 4986.7 4987.5 5605.3 5706.6 5708.8 5896.2 5905.9 5678.6 5729.9 5777.3 5792.8 5823.5 5953.5 5953.8 5954.9 5955.1 5972.8 5561.9 5582.4 5597.7 5634.0 5641.5 5502.5 5507.1 5603.9 5646.9 5682.6 5589.8 5593.9 5600.0 5604.2 5619.1 5573.3 5589.9 5636.4 5637.0 5638.5 5441.2 5541.6 5554.2 5590.3 5612.9 5655.9 5656.8 5661.0 5698.6 5703.1 5279.8 5308.5 5318.5 5512.9 5530.6 12:07:45 INFO - PROCESS | 19898 | 12:07:45 INFO - PROCESS | 19898 | [#1] ext.html Cycles:180 Average:53029.51 Median:3409.29 stddev:100874.87 (2958.8%) stddev-sans-first:101080.87 12:07:45 INFO - PROCESS | 19898 | Values: 544.0 588.8 603.5 619.7 634.9 31507.5 43023.8 43527.8 43762.0 43772.1 43432.3 43655.3 43690.0 43875.6 44120.3 7940.4 8132.1 8702.2 8922.8 8982.6 10315.7 10606.8 10616.5 11099.9 11141.9 10803.2 10868.1 10890.7 10894.2 10894.6 10705.4 10723.0 10759.5 10760.0 10776.2 10593.6 10653.9 10663.1 10669.9 10673.8 41666.2 41948.8 42025.8 42068.8 42105.2 3410.5 3450.3 3625.8 3640.1 3650.8 30984.7 31164.8 31359.4 32287.4 33512.7 3800.4 3953.6 3967.2 4028.6 4106.7 318919.0 320323.4 320879.0 321625.0 321737.0 34160.0 35204.6 55971.0 56303.7 56321.7 36611.0 36692.6 36823.3 36913.8 36921.3 13509.9 13573.4 13589.5 13615.7 13617.8 10051.2 10225.3 11179.4 11311.9 11469.8 8541.7 8575.4 8619.7 8670.1 8680.0 3313.7 3341.5 3370.8 3375.6 3408.0 974.5 1001.9 1023.4 1055.7 1077.6 31268.4 31363.2 31418.4 31421.2 31942.8 1103.9 1158.5 1170.0 1177.0 1210.2 16613.7 16652.5 16778.2 16878.2 17127.3 465485.0 468638.0 470356.0 470840.0 471450.0 56759.7 57165.0 57380.7 57451.4 57551.4 1226.1 1250.7 1331.4 1342.0 1380.4 26695.3 31831.5 32096.4 32243.2 32453.4 48354.5 48866.0 48867.0 48899.5 48970.5 336333.0 336741.0 337536.0 338304.0 338670.0 24399.6 24892.9 26754.6 27248.5 28669.3 39990.0 45814.3 46057.3 46477.5 46562.3 38658.2 38760.4 39352.2 39426.0 41012.4 38269.6 38945.4 39255.4 39606.8 39986.0 39491.0 39961.0 40065.2 40438.0 40883.0 32764.8 35760.8 36221.6 36558.1 36758.4 26936.5 27658.3 27689.9 27851.4 27895.9 12:07:45 INFO - PROCESS | 19898 | 12:07:45 INFO - PROCESS | 19898 | [#2] jquery.html Cycles:180 Average:27728.55 Median:42297.39 stddev:75918.78 (179.5%) stddev-sans-first:76103.96 12:07:45 INFO - PROCESS | 19898 | Values: 369.3 380.4 380.9 380.9 383.8 18710.8 18997.0 19273.6 19376.9 19403.8 18506.7 18582.0 18956.5 18959.7 18965.1 5470.8 5562.3 5812.8 5821.9 5835.0 5628.8 5677.9 5735.7 5742.1 5742.3 5417.9 5594.3 5654.4 5657.1 5705.8 5582.7 5628.9 5637.4 5637.9 5648.8 4986.6 5041.5 5041.6 5046.2 5104.1 22513.0 22538.3 22545.5 22886.2 23026.8 2192.2 2315.8 2418.4 2619.4 2651.4 14058.2 14191.5 14192.8 14274.5 14964.6 1863.5 1864.5 1877.6 1947.3 1953.8 77076.0 78570.2 79455.6 80130.2 80858.6 10004.3 10190.6 10326.3 10328.9 10632.6 14519.2 14525.6 14530.9 14532.8 14555.9 7585.7 7806.6 7924.8 8052.3 8157.4 7624.5 7846.8 7978.7 8095.5 8194.0 6239.2 6370.3 6389.4 6434.3 6652.3 1807.0 1867.1 1867.7 1894.9 1896.1 448.6 728.7 837.4 947.0 1062.5 11070.5 11255.7 11869.5 12048.7 12536.9 447.4 451.0 451.6 452.9 463.1 6406.6 6484.1 6540.5 6553.9 6563.0 454388.0 455908.5 458377.0 460733.0 462224.0 93190.5 94972.5 96682.0 98175.5 101867.0 461.2 467.1 468.5 469.3 469.7 10770.5 10923.9 11046.9 11057.8 11176.8 41763.0 41848.0 41907.8 42010.8 42584.0 52547.7 53039.0 53049.7 60961.7 62790.0 8398.0 8485.9 8657.1 8731.1 8803.1 12655.9 13455.5 13595.8 13755.0 13826.2 11558.5 11845.3 11970.5 12008.7 12442.8 11164.8 11174.4 11363.3 11533.5 11799.4 11697.5 11822.5 11843.0 12346.3 12397.3 8544.5 8657.1 8708.4 8818.9 9029.2 11122.6 11480.8 11760.2 11895.6 11978.8 12:07:45 INFO - PROCESS | 19898 | 12:07:45 INFO - PROCESS | 19898 | [#3] mootools.html Cycles:180 Average:5417.11 Median:5616.18 stddev:2921.55 (52.0%) stddev-sans-first:2914.44 12:07:45 INFO - PROCESS | 19898 | Values: 1438.7 1466.4 1581.2 1734.7 1772.4 7282.7 7595.1 7852.5 8387.7 8402.2 7734.0 8023.8 8028.4 8233.8 8238.8 2310.8 2337.2 2337.3 2338.0 2341.6 2043.1 2122.6 2299.8 2357.4 2363.5 2229.1 2307.0 2308.1 2321.5 2327.7 2300.0 2300.8 2329.6 2340.5 2342.1 2330.9 2337.9 2362.8 2369.0 2371.5 8163.0 8285.1 8288.8 8310.7 8341.2 4909.8 5042.9 5054.1 5054.8 5059.2 3191.9 3272.8 3299.4 3334.5 3390.8 939.4 990.8 1003.0 1026.7 1026.8 11202.1 11276.6 11278.5 11279.1 11279.6 4242.6 4491.8 4506.3 4610.1 4622.9 9619.4 9645.1 9647.4 9649.2 9657.3 5082.7 5089.9 5095.9 5097.2 5106.2 4515.5 4642.6 4645.8 4695.3 4732.9 3771.9 3792.1 3812.1 3908.8 3923.7 1176.4 1215.3 1246.7 1261.9 1266.4 802.3 877.4 930.7 941.1 946.6 5621.1 5675.9 5731.8 5760.7 5898.1 919.3 921.2 928.5 945.5 950.2 3896.6 3987.1 4076.9 4082.5 4180.0 8905.9 9118.5 9201.5 9204.7 9214.7 9050.1 9141.0 9157.9 9169.4 9175.4 7759.8 7892.6 7899.1 7905.8 7922.3 5516.7 5526.9 5611.6 5620.8 5771.6 9208.1 9226.4 9258.6 9337.3 9365.7 8760.8 9036.1 9042.1 9370.1 9382.8 7298.5 7484.9 7486.3 7489.1 7489.8 7921.8 7935.0 7994.6 7996.8 8004.9 7052.0 7109.0 7193.7 7407.9 7597.5 6904.0 6965.0 7083.0 7194.7 7226.7 6455.2 6456.8 6507.1 6513.1 6527.7 4940.1 5012.4 5063.9 5176.1 5192.7 4813.9 4866.9 5082.3 5085.3 5147.3 12:07:45 INFO - PROCESS | 19898 | 12:07:45 INFO - PROCESS | 19898 | [#4] prototype.html Cycles:180 Average:4504.26 Median:5055.21 stddev:1330.77 (26.3%) stddev-sans-first:1296.63 12:07:45 INFO - PROCESS | 19898 | Values: 304.1 314.8 315.8 319.4 320.2 5050.8 5215.7 5219.8 5243.0 5274.4 5059.6 5078.7 5105.4 5113.9 5141.7 4013.7 4034.5 4042.4 4043.9 4075.9 3788.5 3808.3 4055.7 4061.3 4063.5 4024.4 4037.8 4042.5 4050.6 4054.0 4029.3 4033.6 4047.4 4050.5 4057.9 3596.8 3602.8 3603.6 3603.8 3606.2 4933.6 5014.8 5016.3 5019.9 5020.8 4568.6 4571.2 4584.9 4587.8 4604.2 5082.3 5374.3 5384.5 5385.4 5391.0 3821.7 3844.1 3845.1 3848.6 3850.8 5575.3 5595.0 5596.4 5604.6 5626.4 3933.2 3939.9 3941.3 3949.6 3955.9 3839.4 3957.3 3979.4 3988.7 4007.1 4552.9 4560.8 4577.8 4581.8 4583.2 5408.9 5424.8 5428.8 5432.3 5440.5 1321.7 1370.5 1373.5 1382.7 1386.9 851.2 867.4 877.2 882.3 883.6 4602.8 4638.8 4644.1 4647.9 4648.3 4841.8 4846.8 4864.7 4866.9 4881.4 4617.8 4652.0 4656.3 4668.5 4674.4 2788.3 2963.2 2963.4 2967.1 2971.9 5745.8 5768.8 5789.9 5792.1 5797.4 5500.6 5636.4 5688.6 5696.6 5708.8 5750.5 5756.6 5766.9 5770.7 5775.2 5569.9 5570.1 5605.9 5606.6 5612.3 5306.8 5447.5 5505.4 5512.2 5520.3 5690.4 5733.7 5763.3 5767.9 5835.9 3732.4 3833.0 3914.5 3935.4 3937.3 5410.8 5498.9 5513.8 5527.2 5544.4 5319.7 5366.6 5405.5 5406.2 5426.2 5245.8 5384.9 5404.8 5411.5 5415.5 5391.4 5412.8 5413.8 5421.3 5423.9 5441.8 5449.3 5450.6 5479.3 5487.8 5101.9 5310.3 5327.3 5328.8 5359.5 12:07:45 INFO - PROCESS | 19898 | 12:07:45 INFO - PROCESS | 19898 | [#5] yui.html Cycles:180 Average:17061.45 Median:25705.54 stddev:21924.10 (85.3%) stddev-sans-first:21951.19 12:07:45 INFO - PROCESS | 19898 | Values: 702.9 726.1 734.4 815.6 817.5 15471.0 16305.0 16330.5 16350.2 16401.1 14716.6 14866.9 14870.9 14872.6 14915.0 661.1 679.7 801.8 808.5 831.6 816.2 828.4 829.2 829.5 830.4 868.2 868.4 869.0 869.3 870.2 691.5 710.9 844.1 866.2 866.3 635.4 637.6 638.7 641.5 642.0 15035.8 15063.1 15064.2 15066.5 15067.8 14290.8 14292.9 14362.7 14380.8 14457.6 12422.7 12447.1 12557.1 12751.0 12835.9 4420.3 4431.4 4475.6 4552.1 4721.1 67497.0 67554.3 67921.0 68600.7 69101.3 11476.8 11526.6 11543.3 11658.2 11675.9 21047.9 21104.5 21125.0 21154.2 21170.7 8031.2 8091.1 8133.1 8151.8 8261.5 4481.9 4558.4 4567.2 4581.1 4586.5 3280.3 3373.1 3382.5 3388.6 3389.3 587.2 589.4 597.9 606.7 611.1 571.9 608.7 648.7 654.8 658.6 8187.6 8301.8 8363.6 8648.7 8710.2 581.4 626.3 660.8 685.7 688.8 4201.9 4249.2 4289.8 4365.5 4417.5 52022.7 65376.0 80775.6 83243.9 89897.6 47018.5 54210.7 64929.0 68062.0 74221.0 67496.0 68487.0 68845.7 69868.7 71819.3 7569.7 8065.8 8107.9 8342.2 8539.3 45379.3 45598.3 46824.5 46986.8 48121.8 58081.7 58839.4 59683.7 60807.0 62434.4 10904.3 10923.9 11037.2 11667.7 11754.3 12208.4 12278.4 12293.6 12460.1 12745.3 11509.4 11514.0 11702.5 11870.5 12370.7 11308.2 11318.3 11689.6 11828.8 12050.6 10857.5 11276.0 11469.7 13304.7 13386.5 10007.0 10109.4 10419.7 10641.8 10823.2 10629.5 10861.9 10906.5 10957.7 11761.2 12:07:45 INFO - PROCESS | 19898 | -------- Summary: end -------- 12:07:45 INFO - PROCESS | 19898 | 12:07:46 INFO - TEST-INFO | 19898: exit 0 12:07:46 INFO - TEST-OK | dromaeo_css | took 1117880ms 12:07:46 INFO - TEST-START | kraken 12:07:46 INFO - operating with platform_type : linux_ 12:07:46 INFO - Initialising browser for kraken test... 12:07:46 INFO - TEST-INFO | started process 20204 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBGbWEG/profile http://localhost:57317/getInfo.html) 12:07:50 INFO - PROCESS | 20204 | __metrics Screen width/height:1600/1200 12:07:50 INFO - PROCESS | 20204 | colorDepth:24 12:07:50 INFO - PROCESS | 20204 | Browser inner width/height: 1024/697 12:07:50 INFO - PROCESS | 20204 | __metrics 12:07:50 INFO - PROCESS | 20204 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:07:50 INFO - PROCESS | 20204 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:07:51 INFO - PROCESS | 20204 | console.error: PushService: 12:07:51 INFO - PROCESS | 20204 | stateChangeProcessEnqueue: Error transitioning state 12:07:51 INFO - PROCESS | 20204 | UnknownError 12:07:51 INFO - TEST-INFO | 20204: exit 0 12:07:51 INFO - Browser initialized. 12:07:51 INFO - Running cycle 1/1 for kraken test... 12:07:51 INFO - TEST-INFO | started process 20292 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBGbWEG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:08:03 INFO - PROCESS | 20292 | RSS: Main: 172453888 12:08:03 INFO - PROCESS | 20292 | 12:08:06 INFO - PROCESS | 20292 | Cycle 1(1): loaded http://localhost:57317/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57317/tests/kraken/driver.html?testName=audio-beat-detection) 12:08:07 INFO - PROCESS | 20292 | RSS: Main: 228659200 12:08:07 INFO - PROCESS | 20292 | 12:08:09 INFO - PROCESS | 20292 | Cycle 1(1): loaded http://localhost:57317/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57317/tests/kraken/driver.html?testName=audio-dft) 12:08:10 INFO - PROCESS | 20292 | RSS: Main: 215388160 12:08:10 INFO - PROCESS | 20292 | 12:08:13 INFO - PROCESS | 20292 | Cycle 1(1): loaded http://localhost:57317/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57317/tests/kraken/driver.html?testName=audio-fft) 12:08:14 INFO - PROCESS | 20292 | RSS: Main: 297971712 12:08:14 INFO - PROCESS | 20292 | 12:08:16 INFO - PROCESS | 20292 | Cycle 1(1): loaded http://localhost:57317/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57317/tests/kraken/driver.html?testName=audio-oscillator) 12:08:17 INFO - PROCESS | 20292 | RSS: Main: 208588800 12:08:17 INFO - PROCESS | 20292 | 12:08:19 INFO - PROCESS | 20292 | Cycle 1(1): loaded http://localhost:57317/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57317/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:08:19 INFO - PROCESS | 20292 | RSS: Main: 212275200 12:08:19 INFO - PROCESS | 20292 | 12:08:22 INFO - PROCESS | 20292 | Cycle 1(1): loaded http://localhost:57317/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57317/tests/kraken/driver.html?testName=imaging-darkroom) 12:08:23 INFO - PROCESS | 20292 | RSS: Main: 248004608 12:08:23 INFO - PROCESS | 20292 | 12:08:26 INFO - PROCESS | 20292 | Cycle 1(1): loaded http://localhost:57317/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57317/tests/kraken/driver.html?testName=imaging-desaturate) 12:08:27 INFO - PROCESS | 20292 | RSS: Main: 246820864 12:08:27 INFO - PROCESS | 20292 | 12:08:29 INFO - PROCESS | 20292 | Cycle 1(1): loaded http://localhost:57317/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57317/tests/kraken/driver.html?testName=json-parse-financial) 12:08:30 INFO - PROCESS | 20292 | RSS: Main: 246607872 12:08:30 INFO - PROCESS | 20292 | 12:08:32 INFO - PROCESS | 20292 | Cycle 1(1): loaded http://localhost:57317/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57317/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:08:32 INFO - PROCESS | 20292 | RSS: Main: 208457728 12:08:32 INFO - PROCESS | 20292 | 12:08:34 INFO - PROCESS | 20292 | Cycle 1(1): loaded http://localhost:57317/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57317/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:08:35 INFO - PROCESS | 20292 | RSS: Main: 216350720 12:08:35 INFO - PROCESS | 20292 | 12:08:37 INFO - PROCESS | 20292 | Cycle 1(1): loaded http://localhost:57317/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57317/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:08:37 INFO - PROCESS | 20292 | RSS: Main: 225533952 12:08:37 INFO - PROCESS | 20292 | 12:08:40 INFO - PROCESS | 20292 | Cycle 1(1): loaded http://localhost:57317/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57317/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:08:41 INFO - PROCESS | 20292 | RSS: Main: 234029056 12:08:41 INFO - PROCESS | 20292 | 12:08:43 INFO - PROCESS | 20292 | Cycle 1(1): loaded http://localhost:57317/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57317/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:08:44 INFO - PROCESS | 20292 | RSS: Main: 230776832 12:08:44 INFO - PROCESS | 20292 | 12:08:46 INFO - PROCESS | 20292 | Cycle 1(1): loaded http://localhost:57317/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57317/tests/kraken/driver.html?testName=ai-astar) 12:08:46 INFO - PROCESS | 20292 | RSS: Main: 282181632 12:08:46 INFO - PROCESS | 20292 | 12:08:46 INFO - PROCESS | 20292 | __start_tp_report 12:08:46 INFO - PROCESS | 20292 | _x_x_mozilla_page_load 12:08:46 INFO - PROCESS | 20292 | _x_x_mozilla_page_load_details 12:08:46 INFO - PROCESS | 20292 | |i|pagename|runs| 12:08:46 INFO - PROCESS | 20292 | |0;ai-astar;106;113;112;115;113;113;114;113;113;115 12:08:46 INFO - PROCESS | 20292 | |1;audio-beat-detection;155;128;126;161;130;126;123;124;164;134 12:08:46 INFO - PROCESS | 20292 | |2;audio-dft;161;163;162;162;164;164;165;162;161;162 12:08:46 INFO - PROCESS | 20292 | |3;audio-fft;76;76;77;110;77;77;75;77;101;76 12:08:46 INFO - PROCESS | 20292 | |4;audio-oscillator;84;84;126;83;83;84;101;83;84;112 12:08:46 INFO - PROCESS | 20292 | |5;imaging-gaussian-blur;118;118;117;118;117;118;119;119;119;117 12:08:46 INFO - PROCESS | 20292 | |6;imaging-darkroom;146;146;148;146;146;147;146;147;147;146 12:08:46 INFO - PROCESS | 20292 | |7;imaging-desaturate;86;84;85;85;85;85;85;84;85;86 12:08:46 INFO - PROCESS | 20292 | |8;json-parse-financial;54;52;51;52;51;53;53;53;53;54 12:08:46 INFO - PROCESS | 20292 | |9;json-stringify-tinderbox;62;62;62;62;63;62;61;62;62;63 12:08:46 INFO - PROCESS | 20292 | |10;stanford-crypto-aes;82;85;80;89;81;79;80;87;84;85 12:08:46 INFO - PROCESS | 20292 | |11;stanford-crypto-ccm;133;135;142;146;131;137;133;133;181;135 12:08:46 INFO - PROCESS | 20292 | |12;stanford-crypto-pbkdf2;168;171;171;169;173;169;174;175;173;171 12:08:46 INFO - PROCESS | 20292 | |13;stanford-crypto-sha256-iterative;66;65;66;66;65;67;68;64;64;66 12:08:46 INFO - PROCESS | 20292 | __end_tp_report 12:08:46 INFO - PROCESS | 20292 | __start_cc_report 12:08:46 INFO - PROCESS | 20292 | _x_x_mozilla_cycle_collect,1688 12:08:46 INFO - PROCESS | 20292 | __end_cc_report 12:08:46 INFO - PROCESS | 20292 | __startTimestamp1478113726478__endTimestamp 12:08:46 INFO - PROCESS | 20292 | 12:08:46 INFO - PROCESS | 20292 | ------- Summary: start ------- 12:08:46 INFO - PROCESS | 20292 | Number of tests: 14 12:08:46 INFO - PROCESS | 20292 | 12:08:46 INFO - PROCESS | 20292 | [#0] ai-astar Cycles:10 Average:112.70 Median:113.00 stddev:2.54 (2.2%) stddev-sans-first:1.01 12:08:46 INFO - PROCESS | 20292 | Values: 106.0 113.0 112.0 115.0 113.0 113.0 114.0 113.0 113.0 115.0 12:08:46 INFO - PROCESS | 20292 | 12:08:46 INFO - PROCESS | 20292 | [#1] audio-beat-detection Cycles:10 Average:137.10 Median:132.00 stddev:16.24 (12.3%) stddev-sans-first:15.89 12:08:46 INFO - PROCESS | 20292 | Values: 155.0 128.0 126.0 161.0 130.0 126.0 123.0 124.0 164.0 134.0 12:08:46 INFO - PROCESS | 20292 | 12:08:46 INFO - PROCESS | 20292 | [#2] audio-dft Cycles:10 Average:162.60 Median:162.50 stddev:1.35 (0.8%) stddev-sans-first:1.30 12:08:46 INFO - PROCESS | 20292 | Values: 161.0 163.0 162.0 162.0 164.0 164.0 165.0 162.0 161.0 162.0 12:08:46 INFO - PROCESS | 20292 | 12:08:46 INFO - PROCESS | 20292 | [#3] audio-fft Cycles:10 Average:82.20 Median:76.50 stddev:12.48 (16.3%) stddev-sans-first:13.03 12:08:46 INFO - PROCESS | 20292 | Values: 76.0 76.0 77.0 110.0 77.0 77.0 75.0 77.0 101.0 76.0 12:08:46 INFO - PROCESS | 20292 | 12:08:46 INFO - PROCESS | 20292 | [#4] audio-oscillator Cycles:10 Average:92.40 Median:83.50 stddev:15.40 (18.4%) stddev-sans-first:16.03 12:08:46 INFO - PROCESS | 20292 | Values: 84.0 84.0 126.0 83.0 83.0 84.0 101.0 83.0 84.0 112.0 12:08:46 INFO - PROCESS | 20292 | 12:08:46 INFO - PROCESS | 20292 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 12:08:46 INFO - PROCESS | 20292 | Values: 118.0 118.0 117.0 118.0 117.0 118.0 119.0 119.0 119.0 117.0 12:08:46 INFO - PROCESS | 20292 | 12:08:46 INFO - PROCESS | 20292 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 12:08:46 INFO - PROCESS | 20292 | Values: 146.0 146.0 148.0 146.0 146.0 147.0 146.0 147.0 147.0 146.0 12:08:46 INFO - PROCESS | 20292 | 12:08:46 INFO - PROCESS | 20292 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.00 stddev:0.67 (0.8%) stddev-sans-first:0.60 12:08:46 INFO - PROCESS | 20292 | Values: 86.0 84.0 85.0 85.0 85.0 85.0 85.0 84.0 85.0 86.0 12:08:46 INFO - PROCESS | 20292 | 12:08:46 INFO - PROCESS | 20292 | [#8] json-parse-financial Cycles:10 Average:52.60 Median:53.00 stddev:1.07 (2.0%) stddev-sans-first:1.01 12:08:46 INFO - PROCESS | 20292 | Values: 54.0 52.0 51.0 52.0 51.0 53.0 53.0 53.0 53.0 54.0 12:08:46 INFO - PROCESS | 20292 | 12:08:46 INFO - PROCESS | 20292 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 12:08:46 INFO - PROCESS | 20292 | Values: 62.0 62.0 62.0 62.0 63.0 62.0 61.0 62.0 62.0 63.0 12:08:46 INFO - PROCESS | 20292 | 12:08:46 INFO - PROCESS | 20292 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:84.50 stddev:3.33 (3.9%) stddev-sans-first:3.50 12:08:46 INFO - PROCESS | 20292 | Values: 82.0 85.0 80.0 89.0 81.0 79.0 80.0 87.0 84.0 85.0 12:08:46 INFO - PROCESS | 20292 | 12:08:46 INFO - PROCESS | 20292 | [#11] stanford-crypto-ccm Cycles:10 Average:140.60 Median:136.00 stddev:14.92 (11.0%) stddev-sans-first:15.57 12:08:46 INFO - PROCESS | 20292 | Values: 133.0 135.0 142.0 146.0 131.0 137.0 133.0 133.0 181.0 135.0 12:08:46 INFO - PROCESS | 20292 | 12:08:46 INFO - PROCESS | 20292 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.40 Median:172.00 stddev:2.32 (1.3%) stddev-sans-first:2.11 12:08:46 INFO - PROCESS | 20292 | Values: 168.0 171.0 171.0 169.0 173.0 169.0 174.0 175.0 173.0 171.0 12:08:46 INFO - PROCESS | 20292 | 12:08:46 INFO - PROCESS | 20292 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:66.00 stddev:1.25 (1.9%) stddev-sans-first:1.32 12:08:46 INFO - PROCESS | 20292 | Values: 66.0 65.0 66.0 66.0 65.0 67.0 68.0 64.0 64.0 66.0 12:08:46 INFO - PROCESS | 20292 | -------- Summary: end -------- 12:08:46 INFO - PROCESS | 20292 | 12:08:47 INFO - TEST-INFO | 20292: exit 0 12:08:47 INFO - TEST-OK | kraken | took 61414ms 12:08:47 INFO - SUITE-END | took 1179s 12:08:48 INFO - Completed test suite (00:19:39) 12:08:48 INFO - javascript benchmark 12:08:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3052.832094234817, 3070.6315242170945, 3105.4875945469, 3122.0, 3124.1720943949845, 5228.111221092414, 5271.130263506527, 5337.066013447646, 5395.136778115502, 5418.972905135473, 5324.5740340772745, 5328.46715328467, 5332.493413125757, 5338.3860856001575, 5342.1452567589195, 4811.4226292844905, 4840.443349014856, 4854.902901941959, 4883.4628190898975, 4887.120318342697, 4930.630202734809, 4943.382077240345, 4959.404871415435, 4964.776585053663, 4969.875753106165, 4873.756312184394, 4893.8287159949405, 4942.357493525855, 4942.579880710144, 4971.4034315882145, 4956.578690811285, 4958.429780575244, 4978.253262010728, 4978.950210497885, 5043.646944713872, 4759.048190361941, 4788.664793464459, 4797.71213727174, 4874.122657921573, 4885.60915126789, 5299.443558426348, 5311.840644780663, 5317.973410132925, 5331.040412725708, 5394.460553944614, 5627.127795191752, 5688.374278829326, 5700.087985922232, 5700.800471983461, 5702.2301989231755, 5584.832455026356, 5633.60564760467, 5690.430956904318, 5753.654780713171, 5822.417758224144, 5314.813981510667, 5342.893142137135, 5345.919811202835, 5400.405955344909, 5409.864753381197, 5824.417558244227, 5830.76676932918, 5831.446012628793, 5837.416258374129, 5840.707964601753, 5405.21624364465, 5520.006398848246, 5600.719964001783, 5605.747741351649, 5614.831555053355, 5692.31692196939, 5700.059490184073, 5735.684537350486, 5742.31092268922, 5813.709314534256, 5660.801871934463, 5709.0, 5711.657300561979, 5721.456461636138, 5729.5702822288495, 5543.501084902378, 5731.168980497804, 5734.569907256972, 5738.799142030092, 5741.712914354265, 4338.023944612437, 4389.868303950887, 4410.713303635253, 4450.310201918708, 4453.710508816916, 3942.64516193544, 3943.152222272225, 3961.960380396159, 3990.880273591797, 3996.6003399659803, 5481.342238931354, 5481.424450432647, 5492.148716948879, 5493.093639549509, 5544.86330302287, 5585.720713964285, 5623.240862483594, 5685.77256909719, 5702.0, 5795.507381872504, 5393.352797664305, 5407.405185429599, 5411.512963833274, 5458.6724796512335, 5484.561235101182, 4960.379952505937, 4966.925496117561, 4968.254761785689, 4986.725730084808, 4987.451380348159, 5605.299337582802, 5706.629069110661, 5708.828735137787, 5896.174535565025, 5905.881882362414, 5678.630888992202, 5729.942700573108, 5777.335606405317, 5792.768289268382, 5823.505002074701, 5953.464188223081, 5953.821385358447, 5954.910676339945, 5955.106733989936, 5972.790952316648, 5561.860953476195, 5582.385937546947, 5597.692126933058, 5634.0, 5641.5204707600315, 5502.532284755841, 5507.146392309199, 5603.915941260966, 5646.943530564642, 5682.6306290091015, 5589.832305030855, 5593.888122237614, 5600.047991841316, 5604.159376093618, 5619.129034999582, 5573.331200255995, 5589.916151257653, 5636.408177141341, 5637.0, 5638.4925356718095, 5441.183822426668, 5541.584381171348, 5554.166874968625, 5590.329160500766, 5612.943870561406, 5655.858603534944, 5656.830295091154, 5661.0, 5698.572607054404, 5703.116017017369, 5279.788808447773, 5308.522232998894, 5318.468153184651, 5512.889742205053, 5530.557555395479], "value": 5275.326490403283, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.9727065959058, 588.8174665853585, 603.4779915373201, 619.6777675608683, 634.853983583776, 31507.527387089212, 43023.78488107559, 43527.782361088226, 43762.0, 43772.12455750887, 43432.348514772304, 43655.3451698224, 43689.975652799934, 43875.56124438754, 44120.3381949271, 7940.36477081835, 8132.105468398471, 8702.173293537104, 8922.821543569125, 8982.64069437225, 10315.690529284133, 10606.840897386546, 10616.522256498438, 11099.889001110007, 11141.888581114166, 10803.243772935897, 10868.130549556017, 10890.727731806688, 10894.237403381767, 10894.618688345909, 10705.411202383866, 10723.03492685662, 10759.515821788038, 10760.0, 10776.19178561611, 10593.576256949713, 10653.946730266376, 10663.093637040862, 10669.893301066968, 10673.786524269548, 41666.1666766666, 41948.79025604883, 42025.78987105045, 42068.78965605183, 42105.157896842196, 3410.539577157077, 3450.3271861986923, 3625.800580968046, 3640.10817349751, 3650.7809531428197, 30984.690153098407, 31164.844175778977, 31359.37281254385, 32287.354252915044, 33512.664873351445, 3800.448934904451, 3953.604639536052, 3967.1668949520636, 4028.5769994150487, 4106.7125301228925, 318919.0, 320323.3983830089, 320879.0, 321625.0, 321737.0, 34160.0, 35204.64795352065, 55971.0, 56303.71848140733, 56321.7183914086, 36611.0, 36692.63307366892, 36823.26353472916, 36913.81543092321, 36921.26157476889, 13509.932450337685, 13573.389197486136, 13589.52436664712, 13615.659608509668, 13617.795733064011, 10051.195904327637, 10225.284230103971, 11179.385133817555, 11311.886881131084, 11469.827952580717, 8541.701040463555, 8575.356848236408, 8619.741407757778, 8670.132986701405, 8680.0, 3313.685199906005, 3341.4820702791108, 3370.79775213488, 3375.645557216506, 3408.0457471907907, 974.4835237324229, 1001.9248556358302, 1023.3910823060268, 1055.693848783844, 1077.617445806743, 31268.37463250768, 31363.215919602193, 31418.37163256722, 31421.214469637984, 31942.840285798422, 1103.906167975715, 1158.472894832849, 1169.9590514332128, 1176.9588064417703, 1210.189173253922, 16613.74710440124, 16652.50042498727, 16778.244978975974, 16878.156092195342, 17127.314907403565, 465485.0, 468638.0, 470356.0, 470840.0, 471450.0, 56759.71620141873, 57165.0, 57380.71309643425, 57451.42548574544, 57551.424485755444, 1226.05593692856, 1250.7498500299976, 1331.3542931677935, 1341.9932900335436, 1380.42712274407, 26695.33261668474, 31831.522527161647, 32096.358072837946, 32243.193920152185, 32453.350932980735, 48354.51645483641, 48866.0, 48867.0, 48899.51100489092, 48970.51029489802, 336333.0, 336741.0, 337536.0, 338304.0, 338670.0, 24399.634005490287, 24892.875535622206, 26754.59868102019, 27248.455030899666, 28669.28326791847, 39990.0, 45814.31278530892, 46057.30914036225, 46477.53522464732, 46562.30156547587, 38658.2268354637, 38760.418593720555, 39352.21295574015, 39426.0, 41012.38481422721, 38269.617303826606, 38945.41581876217, 39255.41116883306, 39606.80196598999, 39986.0, 39491.0, 39961.0, 40065.1986960265, 40437.98905027398, 40883.0, 32764.836175818968, 35760.821195893855, 36221.63778362288, 36558.086047849014, 36758.44862327121, 26936.461270774867, 27658.308542286602, 27689.861550692116, 27851.44297114006, 27895.860520697268], "value": 18552.79452136849, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.3020191837428, 380.42175892643183, 380.89525380520337, 380.92000679857233, 383.77165586476036, 18710.812891871075, 18997.0, 19273.614527709455, 19376.9031154844, 19403.805961940376, 18506.722399164024, 18582.0, 18956.526086847836, 18959.715604265948, 18965.14656840442, 5470.8085217017215, 5562.332520097584, 5812.82561523155, 5821.8835623287505, 5835.0, 5628.774849006035, 5677.8580535486735, 5735.713214339266, 5742.138679198112, 5742.253507044078, 5417.891642167155, 5594.272744543204, 5654.434556544354, 5657.094864821629, 5705.800296989606, 5582.720863956806, 5628.887422251532, 5637.379888212273, 5637.887242255173, 5648.830535083954, 4986.601071914238, 5041.521055499722, 5041.647084704072, 5046.167382381939, 5104.05574968632, 22513.0, 22538.323850284516, 22545.549089018292, 22886.198983035512, 23026.76973230263, 2192.215094283191, 2315.8494697844753, 2418.4316685578874, 2619.4368210834573, 2651.4299425623585, 14058.156510609397, 14191.503297384543, 14192.787108193384, 14274.500392486214, 14964.551063468114, 1863.5341164708823, 1864.5059059349283, 1877.633861397028, 1947.3476385410904, 1953.7753158386824, 77076.0, 78570.21429785629, 79455.6027219866, 80130.19869801344, 80858.59570702109, 10004.349717268355, 10190.592376305012, 10326.277160598685, 10328.948355258175, 10632.627858024933, 14519.201443920474, 14525.636859078608, 14530.927345363418, 14532.782008269884, 14555.854441455662, 7585.658645360862, 7806.57063861493, 7924.801879953047, 8052.315553178046, 8157.428979971463, 7624.5425274483705, 7846.8430631387055, 7978.6808527659405, 8095.5142691438705, 8193.95903020493, 6239.220097487814, 6370.331115232834, 6389.361063893573, 6434.292227854932, 6652.334766523406, 1806.97289540657, 1867.1224524473475, 1867.6731571975122, 1894.8957807320453, 1896.099352807433, 448.6406189246588, 728.6903066196951, 837.409626213518, 947.0387556630026, 1062.4900047977014, 11070.501827417786, 11255.66233013011, 11869.525218991144, 12048.698782530508, 12536.874631253571, 447.3692094147237, 450.9549045095464, 451.61612629265517, 452.93432452294235, 463.1408736793267, 6406.647634380154, 6484.059811327331, 6540.50946179029, 6553.901691474632, 6563.0, 454388.0, 455908.4523589339, 458377.0, 460733.0, 462224.0, 93190.53404732933, 94972.52513737525, 96682.0, 98175.50912245394, 101867.0, 461.1514812744566, 467.1078240560513, 468.5197672385832, 469.3312030356728, 469.72051629280526, 10770.461476925966, 10923.945380273048, 11046.944765276123, 11057.83413248818, 11176.776464470828, 41763.0, 41848.0, 41907.79046104872, 42010.78994605008, 42584.0, 52547.73726131345, 53039.0, 53049.734751325996, 60961.69519152376, 62790.0, 8397.95801020991, 8485.872711909204, 8657.134286571292, 8731.126887311219, 8803.119688031145, 12655.87344126547, 13455.46178152863, 13595.796063058864, 13755.0, 13826.239556824068, 11558.47986840611, 11845.348505832262, 11970.461329240032, 12008.699782505508, 12442.813357799821, 11164.776704465703, 11174.441277935908, 11363.318200907972, 11533.538658453568, 11799.410029498318, 11697.532098716296, 11822.527098915947, 11843.0, 12346.320952347707, 12397.318147501974, 8544.487330760174, 8657.108733565767, 8708.390412671051, 8818.91181088181, 9029.187373136449, 11122.61070862516, 11480.770384592095, 11760.176787624785, 11895.583654572049, 11978.76042479163], "value": 8494.529545663301, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1438.7338342406656, 1466.4427517543336, 1581.2014932459106, 1734.6877562038844, 1772.4239622122814, 7282.745103921364, 7595.12656044555, 7852.450328477002, 8387.664493420263, 8402.20179082987, 7734.0, 8023.759287221378, 8028.3978701597325, 8233.752987410373, 8238.752837414871, 2310.8266879983985, 2337.1703045418885, 2337.345543247885, 2338.0414030247603, 2341.613633750429, 2043.1316690406518, 2122.586095711337, 2299.8045166160814, 2357.3988632898586, 2363.456405026845, 2229.108356657334, 2306.9884650576723, 2308.0998410619873, 2321.5472982768365, 2327.650852372149, 2300.0, 2300.815934725218, 2329.569029729497, 2340.5318936212657, 2342.0982921575314, 2330.8718020508863, 2337.9181728639587, 2362.8109751219863, 2369.040538581877, 2371.537550177716, 8162.959185204096, 8285.088640249567, 8288.751337459886, 8310.70912518065, 8341.20758527945, 4909.828156014522, 5042.899142017139, 5054.064997975386, 5054.772535235923, 5059.215821547666, 3191.9112763344724, 3272.836358182105, 3299.4390953537954, 3334.483155110962, 3390.762646614738, 939.4034787909726, 990.8166989106966, 1002.9749256268578, 1026.702256345659, 1026.7792424628667, 11202.103831693445, 11276.605318813885, 11278.492467838885, 11279.097672186206, 11279.605213817476, 4242.575742425733, 4491.842785502492, 4506.278995360792, 4610.124076425535, 4622.930656040162, 9619.422834629944, 9645.131938125462, 9647.421154730739, 9649.179819715402, 9657.275704322063, 5082.695038297714, 5089.872753181126, 5095.949040509621, 5097.235414687752, 5106.208537676666, 4515.458145022619, 4642.628589712815, 4645.790939407735, 4695.272232803853, 4732.929006064912, 3771.9245615087543, 3792.1467669774634, 3812.1422679897355, 3908.8078136168174, 3923.7449565778134, 1176.4353708914648, 1215.2890559023072, 1246.7007918099591, 1261.9147533121509, 1266.3731452930674, 802.2899733735686, 877.3902138014018, 930.6784366200012, 941.1294552538874, 946.6166202687922, 5621.100623900156, 5675.914861277084, 5731.828045158652, 5760.683162426107, 5898.085796701518, 919.3013309884402, 921.15714121578, 928.5496534180917, 945.5177859291811, 950.2160717408028, 3896.5518965318784, 3987.0829709167056, 4076.8573099941955, 4082.4692789937712, 4179.97910010448, 8905.866412003825, 9118.452892826452, 9201.493917834583, 9204.677836275698, 9214.677486287948, 9050.09499050103, 9141.0, 9157.862632060524, 9169.449833009907, 9175.403598766192, 7759.7672069838, 7892.565908875067, 7899.131095579482, 7905.841883162419, 7922.326602238759, 5516.696581687886, 5526.917096243479, 5611.551075913999, 5620.803271885465, 5771.59598828078, 9208.079192080739, 9226.446413215228, 9258.583363748783, 9337.299702522203, 9365.719028429157, 8760.824783504167, 9036.141566551167, 9042.095790420904, 9370.062993700576, 9382.765430864283, 7298.4891057625455, 7484.887726684213, 7486.326230639269, 7489.063867016623, 7489.775306740807, 7921.841563168589, 7934.960325198337, 7994.640241189277, 7996.800079997814, 8004.919950800418, 7052.0, 7109.0, 7193.748218812317, 7407.851842963003, 7597.468177227541, 6904.0, 6964.965175174092, 7082.964585177041, 7194.676239569337, 7226.674799633924, 6455.160829092376, 6456.838579035561, 6507.089007539043, 6513.088167656437, 6527.67361631926, 4940.086084074458, 5012.373453318335, 5063.949360506348, 5176.1200595898035, 5192.662476938987, 4813.879653008703, 4866.926996095132, 5082.33929589151, 5085.262636917701, 5147.3308469898675], "value": 4405.986025516278, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.13928582112624, 314.7702177410489, 315.8310303987367, 319.3804020200811, 320.2426261890628, 5050.84847454576, 5215.713135777531, 5219.84340469786, 5242.973785131078, 5274.393444753854, 5059.569936555397, 5078.695278283296, 5105.412877519087, 5113.897722045557, 5141.742912854352, 4013.7190396672245, 4034.4553485279407, 4042.4138499917494, 4043.939340909896, 4075.8981025474304, 3788.48855404521, 3808.295465338921, 4055.71609987301, 4061.2689715851134, 4063.4514340564087, 4024.376221685629, 4037.798110094498, 4042.4744783178294, 4050.5544390117066, 4053.9594604053877, 4029.254587901218, 4033.636972672459, 4047.352423612208, 4050.4734384530116, 4057.8985525361954, 3596.8381422835773, 3602.7658202217035, 3603.6396360364015, 3603.8467690339103, 3606.242689035306, 4933.580645645088, 5014.824481143142, 5016.3227964224725, 5019.949800501985, 5020.799168033274, 4568.634509239253, 4571.2457444521615, 4584.885377865547, 4587.839425620121, 4604.194266003436, 5082.263071854561, 5374.301340825707, 5384.461553844584, 5385.434529374437, 5390.973045134789, 3821.6560509554274, 3844.0774214188673, 3845.1348446599573, 3848.5766565677754, 3850.8267127979307, 5575.275214222166, 5595.0, 5596.4403559644115, 5604.570834437192, 5626.381098079167, 3933.1543718100747, 3939.881803545898, 3941.3299739044432, 3949.6445319921345, 3955.861544845974, 3839.434606527427, 3957.3074711925296, 3979.442877997025, 3988.703671306837, 4007.1184339445276, 4552.863414097583, 4560.771961401917, 4577.793999270041, 4581.770911454414, 4583.175028494837, 5408.864778380494, 5424.783008679608, 5428.83713488596, 5432.320959880015, 5440.484397949692, 1321.6585166056461, 1370.451819272299, 1373.4712135827779, 1382.7303675783328, 1386.9375878085511, 851.1871163039283, 867.3971589745066, 877.1973644115691, 882.298572634757, 883.6112110671284, 4602.792874320664, 4638.84293803383, 4644.117617652635, 4647.86056418308, 4648.28075575792, 4841.782119804618, 4846.825329409243, 4864.708117512961, 4866.853994380174, 4881.435857473274, 4617.769111544477, 4651.953480465219, 4656.278276867091, 4668.463126740468, 4674.392328997209, 2788.2611108055976, 2963.199936017263, 2963.422132684149, 2967.124698214032, 2971.93010516214, 5745.827625171251, 5768.826935191951, 5789.884202316014, 5792.0732682771395, 5797.420257974253, 5500.614956952975, 5636.408177141341, 5688.606291458619, 5696.572757043238, 5708.80019199326, 5750.5112065474905, 5756.5682573807135, 5766.884662306814, 5770.682612456188, 5775.249217601769, 5569.888602227852, 5570.108782594765, 5605.915911261252, 5606.579506536945, 5612.260199338219, 5306.814261500829, 5447.494152689807, 5505.394406615349, 5512.200730894078, 5520.309961254843, 5690.402507736793, 5733.684647344436, 5763.337216220189, 5767.8558036049435, 5835.912461313169, 3732.4401339799247, 3833.0, 3914.4715463412076, 3935.3900145477496, 3937.31097058008, 5410.783568657367, 5498.917516237339, 5513.8345849624575, 5527.176031909541, 5544.390117087037, 5319.680819150709, 5366.570674345965, 5405.486463790145, 5406.21609866575, 5426.158945363475, 5245.763940622604, 5384.865378365415, 5404.783923617312, 5411.458854114557, 5415.458454154553, 5391.433899440659, 5412.7564259607625, 5413.7834486620095, 5421.349438067457, 5423.860989192314, 5441.782328706808, 5449.3460784706085, 5450.645708028966, 5479.315085614298, 5487.75305111263, 5101.862354651788, 5310.309659744208, 5327.280817089643, 5328.7602057906715, 5359.544438722753], "value": 4076.5081483705044, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.8840241360174, 726.1213931143319, 734.4454936522924, 815.5799763121997, 817.5013241922428, 15471.0, 16305.0, 16330.51008469745, 16350.182490875439, 16401.097939613315, 14716.558503244893, 14866.851331486681, 14870.851291487083, 14872.58710422511, 14915.0, 661.0711949710665, 679.6907407129769, 801.791534201109, 808.5229714468462, 831.55096248026, 816.2490508731951, 828.4283844147519, 829.2412442615, 829.4608504472081, 830.3647709502236, 868.2316150207081, 868.4138206710445, 869.0397111192136, 869.3088994249587, 870.2211520689011, 691.5470366909632, 710.9324614161646, 844.1389782421957, 866.2463656618751, 866.2550206822128, 635.3551145587232, 637.6206157336377, 638.7221558622015, 641.470786601056, 641.9967900160469, 15035.774463383059, 15063.096214227182, 15064.246787660573, 15066.548003559801, 15067.849321506754, 14290.785638215435, 14292.857071429256, 14362.712745745132, 14380.784288235685, 14457.638559036002, 12422.689432764162, 12447.128700990934, 12557.121001529897, 12751.0, 12835.87164128356, 4420.270655341897, 4431.423914891076, 4475.552444755531, 4552.089582083597, 4721.102990431807, 67497.0, 67554.32445675578, 67921.0, 68600.6569967152, 69101.30898691049, 11476.827847582294, 11526.635539469413, 11543.307401555934, 11658.242214256046, 11675.941620291844, 21047.8947605261, 21104.472388190417, 21125.049372778263, 21154.15383384678, 21170.682439763415, 8031.196880312039, 8091.109977902426, 8133.064697559738, 8151.755447336589, 8261.545614991113, 4481.865544033684, 4558.430196225472, 4567.246404343313, 4581.129585378834, 4586.541345865454, 3280.311134661748, 3373.0555444475585, 3382.458806590983, 3388.6272510023878, 3389.254364039907, 587.1691556447579, 589.3929252869551, 597.8834127345126, 606.6845240475017, 611.1016805296207, 571.928508936383, 608.6621924831761, 648.6582989084882, 654.8395643067383, 658.6015460646336, 8187.6081066218885, 8301.83396332082, 8363.58182090893, 8648.654053837776, 8710.172533609297, 581.3517927510795, 626.3329554024949, 660.8116686744255, 685.7462738786581, 688.7653830885232, 4201.873943781691, 4249.213895429293, 4289.785510724514, 4365.497967733688, 4417.514073451917, 52022.739886300325, 65376.0, 80775.59612202019, 83243.88730296637, 89897.55051224702, 47018.5298147021, 54210.72894635502, 64929.0, 68062.0, 74221.0, 67496.0, 68487.0, 68845.65577172082, 69868.6506567464, 71819.28180718127, 7569.735059273119, 8065.83868322642, 8107.878381824159, 8342.165783421851, 8539.274161696325, 45379.319310209714, 45598.31602525898, 46824.531754682015, 46986.76506617445, 48121.75939120282, 58081.70959145177, 58839.41160588339, 59683.70158149181, 60807.0, 62434.37565624285, 10904.291221070605, 10923.890761092287, 11037.227394082338, 11667.708307292385, 11754.29474231549, 12208.413143866643, 12278.386080695751, 12293.56972505958, 12460.065495087723, 12745.299008554619, 11509.424528773696, 11514.0, 11702.4733886977, 11870.52517899309, 12370.690732731753, 11308.208425410143, 11318.32090074598, 11689.590864319707, 11828.763424731285, 12050.578229761917, 10857.457127143769, 11276.0, 11469.655910322703, 13304.733905322033, 13386.531471398454, 10007.0, 10109.443980581138, 10419.687409377731, 10641.787164256826, 10823.242373033812, 10629.468526573795, 10861.945690271814, 10906.454677266263, 10957.671269861918, 11761.235519691192], "value": 6963.9441607993585, "unit": "score"}], "name": "dromaeo_css", "value": 6857.589886077641, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 113.0, 112.0, 115.0, 113.0, 113.0, 114.0, 113.0, 113.0, 115.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 128.0, 126.0, 161.0, 130.0, 126.0, 123.0, 124.0, 164.0, 134.0], "value": 137.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 162.0, 162.0, 164.0, 164.0, 165.0, 162.0, 161.0, 162.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 110.0, 77.0, 77.0, 75.0, 77.0, 101.0, 76.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 126.0, 83.0, 83.0, 84.0, 101.0, 83.0, 84.0, 112.0], "value": 92.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 119.0, 119.0, 119.0, 117.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 148.0, 146.0, 146.0, 147.0, 146.0, 147.0, 147.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 85.0, 85.0, 85.0, 85.0, 85.0, 84.0, 85.0, 86.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 51.0, 52.0, 51.0, 53.0, 53.0, 53.0, 53.0, 54.0], "value": 52.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 63.0, 62.0, 61.0, 62.0, 62.0, 63.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 80.0, 89.0, 81.0, 79.0, 80.0, 87.0, 84.0, 85.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 135.0, 142.0, 146.0, 131.0, 137.0, 133.0, 133.0, 181.0, 135.0], "value": 140.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 171.0, 171.0, 169.0, 173.0, 169.0, 174.0, 175.0, 173.0, 171.0], "value": 171.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 66.0, 65.0, 67.0, 68.0, 64.0, 64.0, 66.0], "value": 65.7, "unit": "score"}], "name": "kraken", "value": 1512.1000000000001, "alertThreshold": 2.0}]} 12:08:48 INFO - Return code: 0 12:08:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:08:48 INFO - # TBPL SUCCESS # 12:08:48 INFO - Running post-action listener: _resource_record_post_action 12:08:48 INFO - [mozharness: 2016-11-02 19:08:48.294636Z] Finished run-tests step (success) 12:08:48 INFO - Running post-run listener: _resource_record_post_run 12:08:48 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 393687040; Read time: 4; Write time: 265216 12:08:48 INFO - TinderboxPrint: CPU usage
13.1% 12:08:48 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 12:08:48 INFO - TinderboxPrint: I/O write bytes / time
393,687,040 / 265,216 12:08:48 INFO - TinderboxPrint: CPU idle
8,298.0 (86.9%) 12:08:48 INFO - TinderboxPrint: CPU user
1,201.8 (12.6%) 12:08:48 INFO - TinderboxPrint: Swap in / out
0 / 0 12:08:48 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103919616; Read time: 0; Write time: 85992 12:08:48 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 289767424; Read time: 0; Write time: 179224 12:08:48 INFO - Running post-run listener: _upload_blobber_files 12:08:48 INFO - Blob upload gear active. 12:08:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:08:48 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 12:08:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:08:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:08:49 INFO - (blobuploader) - INFO - Open directory for files ... 12:08:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:08:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:08:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:08:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:08:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:08:52 INFO - (blobuploader) - INFO - Done attempting. 12:08:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:08:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:08:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:08:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:08:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:08:54 INFO - (blobuploader) - INFO - Done attempting. 12:08:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:08:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:08:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:08:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:08:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:08:56 INFO - (blobuploader) - INFO - Done attempting. 12:08:56 INFO - (blobuploader) - INFO - Iteration through files over. 12:08:56 INFO - Return code: 0 12:08:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:08:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:08:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/52971ab49876bcdfe1385f224025bfdb988ee5f667fefae53a3041d936cde3146fd7a18c8f445bfe6305c39b8798e25b92913b4c6f900dbdbb9fa348b631b85a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/42b8928188807da70d5c43c9d5ac5834757097f2250e3bc5178ea15bffc31069da90e9a5729ce930469e45c3f199da8792cba073b16a702c173f45e6ae72b4e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bb1f4ca0564a22c1bd9670c84521e2a1bdf55f2a25b7437d3fdcccf2accd069ac040f9129fed1aa4e030606e9b7925bdf9aa64bea012ad04a23abe135e7ce144"} 12:08:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:08:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:08:56 INFO - Contents: 12:08:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/52971ab49876bcdfe1385f224025bfdb988ee5f667fefae53a3041d936cde3146fd7a18c8f445bfe6305c39b8798e25b92913b4c6f900dbdbb9fa348b631b85a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/42b8928188807da70d5c43c9d5ac5834757097f2250e3bc5178ea15bffc31069da90e9a5729ce930469e45c3f199da8792cba073b16a702c173f45e6ae72b4e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bb1f4ca0564a22c1bd9670c84521e2a1bdf55f2a25b7437d3fdcccf2accd069ac040f9129fed1aa4e030606e9b7925bdf9aa64bea012ad04a23abe135e7ce144"} 12:08:56 INFO - Running post-run listener: copy_logs_to_upload_dir 12:08:56 INFO - Copying logs to upload dir... 12:08:56 INFO - mkdir: /builds/slave/test/build/upload/logs 12:08:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.118094 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-11-02 12:08:56.730641) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-02 12:08:56.734761) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1478112494.264922-979874318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/52971ab49876bcdfe1385f224025bfdb988ee5f667fefae53a3041d936cde3146fd7a18c8f445bfe6305c39b8798e25b92913b4c6f900dbdbb9fa348b631b85a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/42b8928188807da70d5c43c9d5ac5834757097f2250e3bc5178ea15bffc31069da90e9a5729ce930469e45c3f199da8792cba073b16a702c173f45e6ae72b4e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bb1f4ca0564a22c1bd9670c84521e2a1bdf55f2a25b7437d3fdcccf2accd069ac040f9129fed1aa4e030606e9b7925bdf9aa64bea012ad04a23abe135e7ce144"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478050521/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011425 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478050521/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/52971ab49876bcdfe1385f224025bfdb988ee5f667fefae53a3041d936cde3146fd7a18c8f445bfe6305c39b8798e25b92913b4c6f900dbdbb9fa348b631b85a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/42b8928188807da70d5c43c9d5ac5834757097f2250e3bc5178ea15bffc31069da90e9a5729ce930469e45c3f199da8792cba073b16a702c173f45e6ae72b4e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bb1f4ca0564a22c1bd9670c84521e2a1bdf55f2a25b7437d3fdcccf2accd069ac040f9129fed1aa4e030606e9b7925bdf9aa64bea012ad04a23abe135e7ce144"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-02 12:08:56.762831) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 12:08:56.763137) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1478112494.264922-979874318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004434 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 12:08:56.846889) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-02 12:08:56.847427) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-02 12:08:56.847854) ========= ========= Total master_lag: 0.15 =========